builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1475246168.09 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.085827) ========= 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.086499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.086772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.215472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.215815) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 07:36:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-09-30 07:36:08 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099530 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.334229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.334523) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013824 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.383193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:36:08.383500) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 07:36:08,482 truncating revision to first 12 chars 2016-09-30 07:36:08,482 Setting DEBUG logging. 2016-09-30 07:36:08,482 attempt 1/10 2016-09-30 07:36:08,482 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:09,226 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:36:09.501362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.501636) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.502014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.502274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.512092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-30 07:36:09.512376) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:09 INFO - MultiFileLogger online at 20160930 07:36:09 in /builds/slave/test 07:36:09 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:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:09 INFO - {'append_to_log': False, 07:36:09 INFO - 'base_work_dir': '/builds/slave/test', 07:36:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:36:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:09 INFO - 'branch': 'Mozilla-Aurora', 07:36:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:09 INFO - 'config_files': ('talos/linux_config.py',), 07:36:09 INFO - 'default_actions': ('clobber', 07:36:09 INFO - 'read-buildbot-config', 07:36:09 INFO - 'download-and-extract', 07:36:09 INFO - 'populate-webroot', 07:36:09 INFO - 'create-virtualenv', 07:36:09 INFO - 'install', 07:36:09 INFO - 'run-tests'), 07:36:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:09 INFO - 'download_minidump_stackwalk': True, 07:36:09 INFO - 'download_symbols': 'ondemand', 07:36:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:09 INFO - 'installer_path': 'installer.exe', 07:36:09 INFO - 'log_level': 'info', 07:36:09 INFO - 'log_name': 'talos', 07:36:09 INFO - 'log_to_console': True, 07:36:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:09 INFO - 'opt_config_files': (), 07:36:09 INFO - 'pip_index': False, 07:36:09 INFO - 'sps_profile': False, 07:36:09 INFO - 'sps_profile_interval': 0, 07:36:09 INFO - 'suite': 'dromaeojs', 07:36:09 INFO - 'system_bits': '32', 07:36:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:09 INFO - 'title': 'talos-linux64-ix-022', 07:36:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:09 INFO - 'use_talos_json': True, 07:36:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:09 INFO - 'work_dir': 'build'} 07:36:09 INFO - [mozharness: 2016-09-30 14:36:09.708806Z] Running clobber step. 07:36:09 INFO - Running pre-action listener: _resource_record_pre_action 07:36:09 INFO - Running main action method: clobber 07:36:09 INFO - rmtree: /builds/slave/test/build 07:36:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:10 INFO - Running post-action listener: _resource_record_post_action 07:36:10 INFO - [mozharness: 2016-09-30 14:36:10.163417Z] Finished clobber step (success) 07:36:10 INFO - [mozharness: 2016-09-30 14:36:10.163518Z] Running read-buildbot-config step. 07:36:10 INFO - Running pre-action listener: _resource_record_pre_action 07:36:10 INFO - Running main action method: read_buildbot_config 07:36:10 INFO - Using buildbot properties: 07:36:10 INFO - { 07:36:10 INFO - "project": "", 07:36:10 INFO - "product": "firefox", 07:36:10 INFO - "script_repo_revision": "production", 07:36:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:36:10 INFO - "repository": "", 07:36:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:36:10 INFO - "buildid": "20160930013320", 07:36:10 INFO - "pgo_build": "True", 07:36:10 INFO - "basedir": "/builds/slave/test", 07:36:10 INFO - "buildnumber": 543, 07:36:10 INFO - "slavename": "talos-linux64-ix-022", 07:36:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:10 INFO - "platform": "ubuntu64_hw", 07:36:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:36:10 INFO - "branch": "mozilla-aurora", 07:36:10 INFO - "repo_path": "releases/mozilla-aurora", 07:36:10 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:36:10 INFO - "stage_platform": "linux64-pgo", 07:36:10 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:36:10 INFO - "slavebuilddir": "test" 07:36:10 INFO - } 07:36:10 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:10 INFO - Running post-action listener: _resource_record_post_action 07:36:10 INFO - [mozharness: 2016-09-30 14:36:10.165988Z] Finished read-buildbot-config step (success) 07:36:10 INFO - [mozharness: 2016-09-30 14:36:10.166079Z] Running download-and-extract step. 07:36:10 INFO - Running pre-action listener: _resource_record_pre_action 07:36:10 INFO - Running main action method: download_and_extract 07:36:10 INFO - mkdir: /builds/slave/test/build/tests 07:36:10 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:10 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:10 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:10 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:10 INFO - Downloaded 1361 bytes. 07:36:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:36:10 INFO - Using the following test package requirements: 07:36:10 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:36:10 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:10 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:36:10 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'jsshell-linux-x86_64.zip'], 07:36:10 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:10 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:36:10 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:36:10 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:36:10 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:10 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:10 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:10 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:10 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:11 INFO - Expected file size: 21901358 07:36:15 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:15 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:15 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:15 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:16 INFO - Expected file size: 21901358 07:36:20 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:20 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:20 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:21 INFO - Expected file size: 14414059 07:36:21 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:21 INFO - trying https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:36:21 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:21 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:23 INFO - Downloaded 63921663 bytes. 07:36:23 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:23 INFO - mkdir: /builds/slave/test/properties 07:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:23 INFO - Contents: 07:36:23 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:23 INFO - Running post-action listener: _resource_record_post_action 07:36:23 INFO - Running post-action listener: set_extra_try_arguments 07:36:23 INFO - [mozharness: 2016-09-30 14:36:23.966725Z] Finished download-and-extract step (success) 07:36:23 INFO - [mozharness: 2016-09-30 14:36:23.966955Z] Running populate-webroot step. 07:36:23 INFO - Running pre-action listener: _resource_record_pre_action 07:36:23 INFO - Running main action method: populate_webroot 07:36:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:23 INFO - '--tppagecycles', 07:36:23 INFO - '7'], 07:36:23 INFO - 'tests': ['tsvgm']}}, 07:36:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['damp', 'tps']}, 07:36:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'tests': ['damp', 'tps']}, 07:36:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['dromaeo_dom']}, 07:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['basic_compositor_video']}, 07:36:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['a11yr', 07:36:23 INFO - 'ts_paint', 07:36:23 INFO - 'tpaint', 07:36:23 INFO - 'sessionrestore', 07:36:23 INFO - 'sessionrestore_no_auto_restore', 07:36:23 INFO - 'tabpaint']}, 07:36:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['tsvgx', 07:36:23 INFO - 'tsvgr_opacity', 07:36:23 INFO - 'tart', 07:36:23 INFO - 'tscrollx', 07:36:23 INFO - 'cart']}, 07:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:23 INFO - 'tsvgr_opacity', 07:36:23 INFO - 'tart', 07:36:23 INFO - 'tscrollx', 07:36:23 INFO - 'cart']}, 07:36:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'talos_options': ['--disable-e10s'], 07:36:23 INFO - 'tests': ['tp5o']}, 07:36:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'tests': ['tp5o']}, 07:36:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'talos_options': ['--disable-e10s', 07:36:23 INFO - '--xperf_path', 07:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:23 INFO - 'tests': ['tp5n']}, 07:36:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:23 INFO - 'talos_options': ['--xperf_path', 07:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:23 INFO - 'tests': ['tp5n']}}, 07:36:23 INFO - 'talos.zip': {'path': '', 07:36:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:23 INFO - Running post-action listener: _resource_record_post_action 07:36:23 INFO - [mozharness: 2016-09-30 14:36:23.985937Z] Finished populate-webroot step (success) 07:36:23 INFO - [mozharness: 2016-09-30 14:36:23.986026Z] Running create-virtualenv step. 07:36:23 INFO - Running pre-action listener: _resource_record_pre_action 07:36:23 INFO - Running main action method: create_virtualenv 07:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:23 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:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:24 INFO - Using real prefix '/usr' 07:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:26 INFO - Installing pip.................done. 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 07:36:26 INFO - 'HOME': '/home/cltbld', 07:36:26 INFO - 'LANG': 'en_US.UTF-8', 07:36:26 INFO - 'LANGUAGE': 'en_US:en', 07:36:26 INFO - 'LOGNAME': 'cltbld', 07:36:26 INFO - 'MAIL': '/var/mail/cltbld', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:26 INFO - 'PWD': '/builds/slave/test', 07:36:26 INFO - 'SHELL': '/bin/bash', 07:36:26 INFO - 'SHLVL': '1', 07:36:26 INFO - 'TERM': 'linux', 07:36:26 INFO - 'TMOUT': '86400', 07:36:26 INFO - 'USER': 'cltbld', 07:36:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:26 INFO - '_': '/tools/buildbot/bin/python'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 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:26 INFO - Cleaning up... 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 07:36:26 INFO - 'HOME': '/home/cltbld', 07:36:26 INFO - 'LANG': 'en_US.UTF-8', 07:36:26 INFO - 'LANGUAGE': 'en_US:en', 07:36:26 INFO - 'LOGNAME': 'cltbld', 07:36:26 INFO - 'MAIL': '/var/mail/cltbld', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:26 INFO - 'PWD': '/builds/slave/test', 07:36:26 INFO - 'SHELL': '/bin/bash', 07:36:26 INFO - 'SHLVL': '1', 07:36:26 INFO - 'TERM': 'linux', 07:36:26 INFO - 'TMOUT': '86400', 07:36:26 INFO - 'USER': 'cltbld', 07:36:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:26 INFO - '_': '/tools/buildbot/bin/python'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 INFO - Downloading/unpacking psutil>=3.1.1 07:36:26 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:26 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:26 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:26 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:26 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:26 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:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:28 INFO - Installing collected packages: psutil 07:36:28 INFO - Running setup.py install for psutil 07:36:29 INFO - building 'psutil._psutil_linux' extension 07:36:29 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:29 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:29 INFO - building 'psutil._psutil_posix' extension 07:36:29 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:29 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:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:29 INFO - Successfully installed psutil 07:36:29 INFO - Cleaning up... 07:36:29 INFO - Return code: 0 07:36:29 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 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 mozsystemmonitor==0.3 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 - Downloading mozsystemmonitor-0.3.tar.gz 07:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:31 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:31 INFO - Installing collected packages: mozsystemmonitor 07:36:31 INFO - Running setup.py install for mozsystemmonitor 07:36:31 INFO - Successfully installed mozsystemmonitor 07:36:31 INFO - Cleaning up... 07:36:31 INFO - Return code: 0 07:36:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:31 INFO - Using env: {'DISPLAY': ':0', 07:36:31 INFO - 'HOME': '/home/cltbld', 07:36:31 INFO - 'LANG': 'en_US.UTF-8', 07:36:31 INFO - 'LANGUAGE': 'en_US:en', 07:36:31 INFO - 'LOGNAME': 'cltbld', 07:36:31 INFO - 'MAIL': '/var/mail/cltbld', 07:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:31 INFO - 'MOZ_NO_REMOTE': '1', 07:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:31 INFO - 'NO_EM_RESTART': '1', 07:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:31 INFO - 'PWD': '/builds/slave/test', 07:36:31 INFO - 'SHELL': '/bin/bash', 07:36:31 INFO - 'SHLVL': '1', 07:36:31 INFO - 'TERM': 'linux', 07:36:31 INFO - 'TMOUT': '86400', 07:36:31 INFO - 'USER': 'cltbld', 07:36:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:31 INFO - '_': '/tools/buildbot/bin/python'} 07:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:32 INFO - Downloading/unpacking jsonschema==2.5.1 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:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:34 INFO - warning: no files found matching '*.txt' 07:36:34 INFO - no previously-included directories found matching 'build' 07:36:34 INFO - no previously-included directories found matching 'dist' 07:36:34 INFO - no previously-included directories found matching '.git*' 07:36:34 INFO - Installing collected packages: jsonschema, functools32 07:36:34 INFO - Running setup.py install for functools32 07:36:34 INFO - warning: no files found matching '*.txt' 07:36:34 INFO - no previously-included directories found matching 'build' 07:36:34 INFO - no previously-included directories found matching 'dist' 07:36:34 INFO - no previously-included directories found matching '.git*' 07:36:34 INFO - Successfully installed jsonschema functools32 07:36:34 INFO - Cleaning up... 07:36:34 INFO - Return code: 0 07:36:34 INFO - Installing functools32==3.2.3-2 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', '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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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', 'functools32==3.2.3-2'] 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 functools32==3.2.3-2 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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:34 INFO - Cleaning up... 07:36:34 INFO - Return code: 0 07:36:34 INFO - Installing blobuploader==1.2.4 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', '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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 07:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:37 INFO - Downloading/unpacking docopt==0.6.1 (from 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:37 INFO - Downloading docopt-0.6.1.tar.gz 07:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:37 INFO - Running setup.py install for blobuploader 07:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:37 INFO - Running setup.py install for requests 07:36:37 INFO - Running setup.py install for docopt 07:36:38 INFO - Successfully installed blobuploader requests docopt 07:36:38 INFO - Cleaning up... 07:36:38 INFO - Return code: 0 07:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:38 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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 07:36:38 INFO - 'HOME': '/home/cltbld', 07:36:38 INFO - 'LANG': 'en_US.UTF-8', 07:36:38 INFO - 'LANGUAGE': 'en_US:en', 07:36:38 INFO - 'LOGNAME': 'cltbld', 07:36:38 INFO - 'MAIL': '/var/mail/cltbld', 07:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:38 INFO - 'MOZ_NO_REMOTE': '1', 07:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:38 INFO - 'NO_EM_RESTART': '1', 07:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:38 INFO - 'PWD': '/builds/slave/test', 07:36:38 INFO - 'SHELL': '/bin/bash', 07:36:38 INFO - 'SHLVL': '1', 07:36:38 INFO - 'TERM': 'linux', 07:36:38 INFO - 'TMOUT': '86400', 07:36:38 INFO - 'USER': 'cltbld', 07:36:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:38 INFO - '_': '/tools/buildbot/bin/python'} 07:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:38 INFO - Running setup.py (path:/tmp/pip-mJ5ysO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:38 INFO - Running setup.py (path:/tmp/pip-9O4BMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:38 INFO - Running setup.py (path:/tmp/pip-0yYzCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:38 INFO - Running setup.py (path:/tmp/pip-Z_voUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:38 INFO - Running setup.py (path:/tmp/pip-ogz_wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:38 INFO - Running setup.py (path:/tmp/pip-iBHCDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:38 INFO - Running setup.py (path:/tmp/pip-VKBpAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:38 INFO - Running setup.py (path:/tmp/pip-bCsGud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:38 INFO - Running setup.py (path:/tmp/pip-J1QQ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:38 INFO - Running setup.py (path:/tmp/pip-VJ6y6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:39 INFO - Running setup.py (path:/tmp/pip-LrhtHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:39 INFO - Running setup.py (path:/tmp/pip-2clWAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:39 INFO - Running setup.py (path:/tmp/pip-aCeEm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:39 INFO - Running setup.py (path:/tmp/pip-rXt07p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:39 INFO - Running setup.py (path:/tmp/pip-J9G2PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:39 INFO - Running setup.py (path:/tmp/pip-SDHh3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:39 INFO - Running setup.py (path:/tmp/pip-tiVDbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:39 INFO - Running setup.py install for manifestparser 07:36:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozcrash 07:36:39 INFO - Running setup.py install for mozdebug 07:36:39 INFO - Running setup.py install for mozdevice 07:36:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozfile 07:36:40 INFO - Running setup.py install for mozhttpd 07:36:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozinfo 07:36:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozInstall 07:36:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozleak 07:36:40 INFO - Running setup.py install for mozlog 07:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for moznetwork 07:36:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozprocess 07:36:40 INFO - Running setup.py install for mozprofile 07:36:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozrunner 07:36:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:41 INFO - Running setup.py install for mozscreenshot 07:36:41 INFO - Running setup.py install for moztest 07:36:41 INFO - Running setup.py install for mozversion 07:36:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 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', '--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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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', '--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 --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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 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-ef1r3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Running setup.py (path:/tmp/pip-5WZHuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Running setup.py (path:/tmp/pip-0iL65_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Running setup.py (path:/tmp/pip-EYCV0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Running setup.py (path:/tmp/pip-Sjx2ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Running setup.py (path:/tmp/pip-TwDu72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:42 INFO - Running setup.py (path:/tmp/pip-xyMt2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:42 INFO - Running setup.py (path:/tmp/pip-8szwcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:42 INFO - Running setup.py (path:/tmp/pip-Xm6pnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:42 INFO - Running setup.py (path:/tmp/pip-a3tWUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 INFO - Running setup.py (path:/tmp/pip-QH01SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 INFO - Running setup.py (path:/tmp/pip-R7arT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 INFO - Running setup.py (path:/tmp/pip-Ex3HUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 INFO - Running setup.py (path:/tmp/pip-rcdnAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Running setup.py (path:/tmp/pip-mzndns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Running setup.py (path:/tmp/pip-QMhjZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Running setup.py (path:/tmp/pip-uziW2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:44 INFO - Downloading blessings-1.6.tar.gz 07:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:44 INFO - Installing collected packages: blessings 07:36:44 INFO - Running setup.py install for blessings 07:36:44 INFO - Successfully installed blessings 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:45 INFO - Reading from file tmpfile_stdout 07:36:45 INFO - Current package versions: 07:36:45 INFO - argparse == 1.2.1 07:36:45 INFO - blessings == 1.6 07:36:45 INFO - blobuploader == 1.2.4 07:36:45 INFO - docopt == 0.6.1 07:36:45 INFO - functools32 == 3.2.3-2 07:36:45 INFO - jsonschema == 2.5.1 07:36:45 INFO - manifestparser == 1.1 07:36:45 INFO - mozInstall == 1.12 07:36:45 INFO - mozcrash == 0.17 07:36:45 INFO - mozdebug == 0.1 07:36:45 INFO - mozdevice == 0.48 07:36:45 INFO - mozfile == 1.2 07:36:45 INFO - mozhttpd == 0.7 07:36:45 INFO - mozinfo == 0.9 07:36:45 INFO - mozleak == 0.1 07:36:45 INFO - mozlog == 3.4 07:36:45 INFO - moznetwork == 0.27 07:36:45 INFO - mozprocess == 0.23 07:36:45 INFO - mozprofile == 0.28 07:36:45 INFO - mozrunner == 6.12 07:36:45 INFO - mozscreenshot == 0.1 07:36:45 INFO - mozsystemmonitor == 0.3 07:36:45 INFO - moztest == 0.7 07:36:45 INFO - mozversion == 1.4 07:36:45 INFO - psutil == 3.1.1 07:36:45 INFO - requests == 1.2.3 07:36:45 INFO - wsgiref == 0.1.2 07:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 07:36:45 INFO - 'HOME': '/home/cltbld', 07:36:45 INFO - 'LANG': 'en_US.UTF-8', 07:36:45 INFO - 'LANGUAGE': 'en_US:en', 07:36:45 INFO - 'LOGNAME': 'cltbld', 07:36:45 INFO - 'MAIL': '/var/mail/cltbld', 07:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:45 INFO - 'MOZ_NO_REMOTE': '1', 07:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:45 INFO - 'NO_EM_RESTART': '1', 07:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:45 INFO - 'PWD': '/builds/slave/test', 07:36:45 INFO - 'SHELL': '/bin/bash', 07:36:45 INFO - 'SHLVL': '1', 07:36:45 INFO - 'TERM': 'linux', 07:36:45 INFO - 'TMOUT': '86400', 07:36:45 INFO - 'USER': 'cltbld', 07:36:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:45 INFO - '_': '/tools/buildbot/bin/python'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Cleaning up... 07:36:45 INFO - Return code: 0 07:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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 0x7fd913bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 07:36:45 INFO - 'HOME': '/home/cltbld', 07:36:45 INFO - 'LANG': 'en_US.UTF-8', 07:36:45 INFO - 'LANGUAGE': 'en_US:en', 07:36:45 INFO - 'LOGNAME': 'cltbld', 07:36:45 INFO - 'MAIL': '/var/mail/cltbld', 07:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:45 INFO - 'MOZ_NO_REMOTE': '1', 07:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:45 INFO - 'NO_EM_RESTART': '1', 07:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:45 INFO - 'PWD': '/builds/slave/test', 07:36:45 INFO - 'SHELL': '/bin/bash', 07:36:45 INFO - 'SHLVL': '1', 07:36:45 INFO - 'TERM': 'linux', 07:36:45 INFO - 'TMOUT': '86400', 07:36:45 INFO - 'USER': 'cltbld', 07:36:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:45 INFO - '_': '/tools/buildbot/bin/python'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:45 INFO - Cleaning up... 07:36:45 INFO - Return code: 0 07:36:45 INFO - Running post-action listener: _resource_record_post_action 07:36:45 INFO - Running post-action listener: _start_resource_monitoring 07:36:45 INFO - Starting resource monitoring. 07:36:45 INFO - [mozharness: 2016-09-30 14:36:45.667136Z] Finished create-virtualenv step (success) 07:36:45 INFO - [mozharness: 2016-09-30 14:36:45.667582Z] Running install step. 07:36:45 INFO - Running pre-action listener: _resource_record_pre_action 07:36:45 INFO - Running main action method: install 07:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:45 INFO - Reading from file tmpfile_stdout 07:36:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:45 INFO - Reading from file tmpfile_stdout 07:36:45 INFO - Output received: 07:36:45 INFO - Usage: mozinstall [options] installer 07:36:45 INFO - Options: 07:36:45 INFO - -h, --help show this help message and exit 07:36:45 INFO - -d DEST, --destination=DEST 07:36:45 INFO - Directory to install application into. [default: 07:36:45 INFO - "/builds/slave/test"] 07:36:45 INFO - --app=APP Application being installed. [default: firefox] 07:36:45 INFO - mkdir: /builds/slave/test/build/application 07:36:45 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:45 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:01 INFO - Reading from file tmpfile_stdout 07:37:01 INFO - Output received: 07:37:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:01 INFO - Running post-action listener: _resource_record_post_action 07:37:01 INFO - [mozharness: 2016-09-30 14:37:01.928897Z] Finished install step (success) 07:37:01 INFO - [mozharness: 2016-09-30 14:37:01.929143Z] Running run-tests step. 07:37:01 INFO - Running pre-action listener: _resource_record_pre_action 07:37:01 INFO - Running main action method: run_tests 07:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:01 INFO - Python 2.7.3 07:37:01 INFO - Return code: 0 07:37:01 INFO - grabbing minidump binary from tooltool 07:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:01 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 0x26e0f60>, '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 0x26e1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:01 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:01 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:01 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:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:02 INFO - Return code: 0 07:37:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:02 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-022', '--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:02 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-022 --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:02 INFO - Using env: {'DISPLAY': ':0', 07:37:02 INFO - 'HOME': '/home/cltbld', 07:37:02 INFO - 'LANG': 'en_US.UTF-8', 07:37:02 INFO - 'LANGUAGE': 'en_US:en', 07:37:02 INFO - 'LOGNAME': 'cltbld', 07:37:02 INFO - 'MAIL': '/var/mail/cltbld', 07:37:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:02 INFO - 'MOZ_NO_REMOTE': '1', 07:37:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:02 INFO - 'NO_EM_RESTART': '1', 07:37:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:02 INFO - 'PWD': '/builds/slave/test', 07:37:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:02 INFO - 'SHELL': '/bin/bash', 07:37:02 INFO - 'SHLVL': '1', 07:37:02 INFO - 'TERM': 'linux', 07:37:02 INFO - 'TMOUT': '86400', 07:37:02 INFO - 'USER': 'cltbld', 07:37:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238', 07:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:02 INFO - '_': '/tools/buildbot/bin/python'} 07:37:02 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-022', '--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:02 INFO - mozversion application_buildid: 20160930013320 07:37:02 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:37:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:02 INFO - mozversion application_name: Firefox 07:37:02 INFO - mozversion application_remotingname: firefox-dev 07:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:37:02 INFO - mozversion application_vendor: Mozilla 07:37:02 INFO - mozversion application_version: 51.0a2 07:37:02 INFO - mozversion platform_buildid: 20160930013320 07:37:02 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:37:02 INFO - mozversion platform_version: 51.0a2 07:37:02 INFO - using testdate: 1475246222 07:37:02 INFO - actual date: 1475246222 07:37:02 INFO - starting webserver on 'localhost:37701' 07:37:02 INFO - SUITE-START | Running 2 tests 07:37:02 INFO - TEST-START | dromaeo_css 07:37:02 INFO - operating with platform_type : linux_ 07:37:02 INFO - Initialising browser for dromaeo_css test... 07:37:02 INFO - TEST-INFO | started process 6432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedh5j_/profile http://localhost:37701/getInfo.html) 07:37:06 INFO - PROCESS | 6432 | __metrics Screen width/height:1600/1200 07:37:06 INFO - PROCESS | 6432 | colorDepth:24 07:37:06 INFO - PROCESS | 6432 | Browser inner width/height: 1024/697 07:37:06 INFO - PROCESS | 6432 | __metrics 07:37:07 INFO - PROCESS | 6432 | 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:07 INFO - PROCESS | 6432 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:07 INFO - PROCESS | 6432 | console.error: PushService: 07:37:07 INFO - PROCESS | 6432 | stateChangeProcessEnqueue: Error transitioning state 07:37:07 INFO - PROCESS | 6432 | UnknownError 07:37:08 INFO - TEST-INFO | 6432: exit 0 07:37:08 INFO - Browser initialized. 07:37:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:08 INFO - TEST-INFO | started process 6524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedh5j_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:19 INFO - PROCESS | 6524 | RSS: Main: 144457728 07:37:19 INFO - PROCESS | 6524 | 07:38:11 INFO - PROCESS | 6524 | 1475246291162 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:20 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37701/tests/dromaeo/cssquery-ext.html) 07:40:21 INFO - PROCESS | 6524 | RSS: Main: 262541312 07:40:21 INFO - PROCESS | 6524 | 07:43:23 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-ext.html (next: http://localhost:37701/tests/dromaeo/cssquery-jquery.html) 07:43:24 INFO - PROCESS | 6524 | RSS: Main: 237109248 07:43:24 INFO - PROCESS | 6524 | 07:46:26 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37701/tests/dromaeo/cssquery-mootools.html) 07:46:26 INFO - PROCESS | 6524 | RSS: Main: 198189056 07:46:26 INFO - PROCESS | 6524 | 07:49:28 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37701/tests/dromaeo/cssquery-prototype.html) 07:49:29 INFO - PROCESS | 6524 | RSS: Main: 175714304 07:49:29 INFO - PROCESS | 6524 | 07:52:31 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37701/tests/dromaeo/cssquery-yui.html) 07:52:32 INFO - PROCESS | 6524 | RSS: Main: 179949568 07:52:32 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | Cycle 1(1): loaded http://localhost:37701/tests/dromaeo/cssquery-yui.html (next: http://localhost:37701/tests/dromaeo/cssquery-dojo.html) 07:55:35 INFO - PROCESS | 6524 | RSS: Main: 258101248 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | __start_tp_report 07:55:35 INFO - PROCESS | 6524 | _x_x_mozilla_page_load 07:55:35 INFO - PROCESS | 6524 | _x_x_mozilla_page_load_details 07:55:35 INFO - PROCESS | 6524 | |i|pagename|runs| 07:55:35 INFO - PROCESS | 6524 | |0;dojo.html;3025.8335791531467;3073.4775088235006;3096.7522598192163;3113.4084523940437;3136.8902088426908;5414.512693857557;5519.06175950088;5542.944570554293;5549.38956714761;5564.554835613151;5535.363433205172;5565;5565.3878073412;5569.0254205513975;5579.13523403872;5034.798608055683;5043.924341134886;5083.18669012958;5101.84694459165;5153.381594208681;4885.8778530536665;4889.7066176029375;5091.974540127294;5139;5143.099957507421;4993.051320249159;5002.649814512985;5014.373203349582;5039.420466646346;5049.67177133487;5046.066477701637;5054.292399064152;5114.411842638107;5124.15451450514;5142.897142057138;4770.260609605517;5009.624278179152;5034.697918124888;5065.873353166164;5086.79652813887;5297.12597421425;5404.648697834628;5462.071447853835;5486.067368547317;5496.148097044965;5904.852378690524;5914.940850591482;5989.55078369124;5992.700364981733;6010.909836352458;5644.322681278273;6049.455549000611;6050.183225264577;6058.454739073461;6062.242219722535;5346.385165705916;5514;5553.916691249635;5570;5615.18579805934;6136.9079463808075;6150.323464418911;6150.354212807591;6164.4143806338325;6169.629822210682;5602.663840169603;5896.911546326808;5899.764009439575;5906.704664766745;5906.734196961147;5726.885462290731;5749.3963133871175;5811.88376232473;5823.010088285002;5823.679697616672;5783.88432231353;5784.82645520635;5790.739416726257;5792.044312688444;5792.768289268466;5825.912611310834;5830.329512106077;5833.358330583633;5868.589198756132;5950.851228719317;4577.176108300471;4580.129775342674;4582.725036497821;4602.631789456836;4603.58567728906;4069.4506241656995;4072.9796351018053;4116.6912481564;4125.608067233668;4129.69027322952;5387.4073851876265;5423.538999185034;5507.917381239285;5562.360328562187;5566.2207290979295;5943.108533719977;5944.227250457413;5949.732262048218;5962.433568810956;5987.072003839412;5533.142362933751;5549.084401073858;5608.158776183605;5608.242887210175;5613.663180209201;5043.3191519145175;5063.87340316495;5086;5129.461406552333;5150.072986862326;5989.700514974234;6069.089636554552;6070.9089363658695;6087.512998960073;6108.694565271719;5910.61580997251;5911.231539899785;5914.994450943436;5916.3492015877355;5917.260342457193;5926.111083337534;6051.092336149437;6055.485283750931;6061;6067.120267561268;5790.478856902899;5835.503982161564;5851.239338885917;5856.472917437451;5928.170056192051;6005.699715014319;6029.035354343284;6035.818925432244;6042.697865106639;6043.2748070231855;5904.468597826216;5915.526757859447;5916.349201587908;5923.466887980103;5924.377940316377;5558.916616250679;5671.432856714296;5687.488126068673;5702.714864256687;5716.085426331767;5727.799527016535;5733;5739;5746.13807928814;5767.913481297868;5750.827475175752;5776.740046697824;5786.276715410574;5792.362840087502;5799.536037117105;5393.083175860034;5477.068898287381;5667.801626943202;5671.744771485375;5677.176809362537 07:55:35 INFO - PROCESS | 6524 | |1;ext.html;583.6935608805377;601.6149664214902;606.9544784141187;633.1547384242036;640.8461969127411;35306.2938741225;35594;46559.30161047587;47437.52562474374;47552.76223618877;45042.54957450424;49505;49528;49531;49566.752166239115;9336.159745622892;9459.527023648825;9489.14597686208;9490.952545237264;9506.952465237664;8418.326533877274;8655.221030107288;8657.307415406753;8853.24747396472;10956.397398143099;11105.500252488617;11469.770604587946;11497.447844540964;11499.19505634606;11506.654800356002;11317.717057073598;11367.715807104805;11388.487518061624;11388.886111138949;11390.316581005167;11123;11155.721106972309;11167.441627918653;11225;11244;45815.77092114518;46212.306815397795;46293.53706462926;46316.3052554212;46362.53637463616;3635.1820840310984;3741.2143449875557;3761.153740408414;4018.9397159042637;4209.431726716884;35009.6499035009;35223.119422014395;35424.64575354265;35524.64475355239;35812.28375432503;4690.366800481926;4700.952990470086;4778.235482322846;4782.33047373368;4848.17581011229;259862;260971.9999999981;261580;261955;262185;39071.60928390737;64200.357996420375;64288.678556606916;64296.67851660805;64688.353116469174;39353.2129357417;41660;41660.79169604193;41734;41741.91290435466;17691.469255922344;17861.553461163316;17861.821381786016;17880;17886.731699024524;14948.626284342978;15025.173615451036;15028.248587570577;15044.172570508508;15045.774313385307;8880;8993.820123597623;9348.392354496937;9539.14147726708;9545.093216144454;3615.1142969972525;3625;3653.415453527423;3678.043708635774;3715.108373990277;1080.6649938519083;1092.2790957967702;1095.3427943233996;1097.9725506862392;1122.8652561692486;34326.65673343284;34535;34689.30621387558;34742.82628586841;34784.65215347814;1141.2581821815886;1143.6111722014389;1152.5101831721486;1168.7311918258847;1179.3572502985894;18255.54361140982;18352.265909363476;18362.724559131624;18481.353152639593;18540.814591854178;519884;524247;524857;526191;527786;61532;61883.690581546805;62052.37947620466;62059.379406206266;62232.68883655553;1335.6660834791303;1363.16165558181;1374.6494643865751;1443.3288520837862;1443.6535231544565;31613.367732644758;35055.82472087623;36589.81705091458;37319.81340093282;37572.2485550282;57301;57804.53172809645;58097.70951145217;58151.70924145352;58195;461249;461531;464682;465263;466956;30978.845105774326;31054.53418198774;31391.529127063568;31650.841745792044;31886.36227275488;42963.785181075145;43666.34500482559;44654.776726116164;45407.091858163316;48499;41842;42383.36424953566;42883.56188282903;43447.78276108599;43882.78058609814;41812.372814408416;42753.5724642762;42883.14233715371;43398;43607.78196109126;41802.163956720084;42164.578354216064;42714.359284611375;42990.14019719526;43176.35235471408;34947.825260873535;37641.4353784688;37875;37900.43149352707;38779.418308724824;28401.28996775097;28407;28518.144455665533;28592.714072859006;28797.856010719814 07:55:35 INFO - PROCESS | 6524 | |2;jquery.html;393.5867339293741;398.6750798099547;399.40688078203874;401.62448111016204;417.5824175824176;14754.704905901875;19320.130594123264;20178.192872285126;21195.258165964176;21205.363839084832;15397.538073857775;17535.824641753577;19301.903490482564;19407.611847763037;19938.102785374656;5822.475977162055;6078.848028799272;6083.695815209244;6090.512758979271;6094.451499365056;5531.1426728857095;5755.453231942959;5922.466977971982;6013.128096426016;6014.669193194372;5860.53115750741;5871.148683440899;5871.588988770766;5873.177755114288;5874.588778785486;5817.650940943536;5823.592348535604;7055.576665400093;7296.343329100407;7341.008963789874;6978.581285122909;7093.751718689873;7160.248173941765;7227.457940654419;7235.240299768554;26722.86638566814;26963.46073078547;27128;27289.317767055785;27740.445191096063;2506.5738824399896;2757.489864375097;2793.1201671473623;2814.8874045038174;3256.641769405387;15760;16307.91846040774;16652.50042498727;16707.331706731715;17268.740968885475;2029.3100345882472;2055.0649454498166;2070.8653937494014;2094.675325324577;2101.63221436248;95324.80388774707;97290.51354743252;98877.5056124722;99146.5042674782;101664.49167754114;17477.475675729747;18359.61325027738;18362.35731749409;18529.53676158107;18745.625087498174;32587.674123258937;33651.495227571606;33686.49470257948;33792.32415351679;34303.4854477183;9856.753581160385;10101.292909496266;10352.948235258775;10761.354318740901;11333.943330283295;9138.268938484905;9289.163975242125;9324.487153206639;9526.714198574055;9526.904730952601;8981.550922453851;9322;9346.252299815998;9421.952890235505;9460.675505429246;3101.6278046634548;3238.757093217971;3361.6638336166675;3489.4242449995972;3555.7510974232073;938.3103418987039;974.4591751577942;975.3075316525204;1013.9340942838692;1052.084686322904;19110.90444547796;19429.80570194308;19443.611127777363;19456.513587160433;19970.60058798816;1008.1732978957331;1019.2610357490908;1027.2398425165325;1031.7369070886875;1045.9006394392673;10620.309679870783;11168.609098681507;11212.887871121347;11300.378479183724;11325.377104259345;520180;521982;537174;541049;542186;93542.53228733812;94837;97617.5119124414;97813.51093244489;102185;1039.8284283093205;1050.7373156710823;1092.322759888874;1095.8301463273206;1100.8568886044764;17798.37705680295;18088.909555452137;18277.54306142357;18429.53926151803;18638.53403664919;41271.1745765089;44824.32763508485;44964.77517612391;45424.77287613541;46964;45565.54434455746;56964;58635;65116.67441662761;67235;8414.495130292202;8560.828783424422;8705.390622656354;8762.518061506678;8875.245604123464;13201.20792752438;13435;13656.248906309851;13805.17168969865;14157.150570965776;11822.881771182178;11828.70428239301;11857.5849845255;11924.165308428326;12132.636020919386;11426.885731142915;11640.417979101181;11973.10201734856;11975.101867360157;12028.398580070787;12343.19769214998;12369.690757730768;12377.257364558156;12524.311162885764;12764.17032892859;8556.18716221958;8577.871331930151;8790.033096359522;8885.777855553662;9129.178373946377;9144.63421463134;11385.601503947322;12004.939975300067;12110.333931633844;12465.813012804996 07:55:35 INFO - PROCESS | 6524 | |3;mootools.html;1498.7452133137365;1516.848315168483;1628.080134723881;1726.33536088606;1755.8331958463941;7807.102183248928;8394.328453723703;8394.454360466572;8399.91600083999;8412;7317.158526769423;7511.962440187805;7917.247861453167;8074.515529068245;8279.379046571516;2361.3034154924294;2381.416552944531;2382.5473160099527;2384;2385.320183747632;2354.6703461515403;2361.3624321433203;2405.915792947247;2405.9639105413435;2407.0492155598527;2074.605824893273;2145.3778404262744;2145.9356219313368;2152.45112496314;2267.0591704442636;2323.604987152188;2352.447174913894;2353.0940587873706;2353.3998830298165;2357.3045951444365;2266.444721043355;2270.3529494094105;2270.648049552322;2284.6116160252795;2403.062805505854;8120;8234.876476852853;8285.668573257062;8312.127226641236;8313.875291870627;4992;5112.667676601046;5121.078205922932;5124.410692770304;5133.640645154841;3209.3741720364537;3325.418051840918;3327.2680010397917;3332.683395077464;3348.11275012122;1126.9042131418757;1160.79105760963;1168.263993683982;1174.6593487888501;1206.2641788509002;10693.83959240612;10953.726156846064;11027.00756931872;11224.494897729623;11315.434228288635;4209.284421648327;4294;4432.069265454226;4439.4006809080365;4444.933326000112;9055.59249833759;9066.773330666654;9067.68263110788;9070.81858362829;9087.273018158532;5043.924341134886;5045.495450454925;5045.495450454925;5053.418856831438;5054.7472626368535;4639.721616703008;4755.95244047562;4765.1660959331975;4766.237402015661;4767.404074490689;3711.9628803711616;3725.683316918038;3789.033796381905;3844.6347596978244;3846.2307538492414;1106.3583121789343;1119.6137332620233;1119.7144728094283;1119.7424592343643;1122.7137080044536;929.2612373163352;1039.7972395382978;1056.7886422715335;1064.494365176535;1068.5084860963889;5907.1139329100115;5957;5984.850378740566;6048.909266361008;6392.808215753535;981.7202097402206;992.4442312305132;1002.7844013536978;1017.4200705597887;1022.754538910656;4205.957940420618;4268.722533035343;4333.414988976511;4339.869803905888;4345.804438800262;9800.509974501247;10173.23700722434;10193.133583645473;10204.38773673582;10239.948800255952;10160.33957792741;10177.03318184786;10187.08316251526;10192.388456692473;10212.591496340212;7682.769516914502;7698;7731.729389471341;7837.37301015906;7841;5760.8271751847515;5799.5070419014855;5875.588708790344;5880.382559831156;6074.453299203093;9390.154886060287;9464.905350946678;9525.095115963972;9546.18857397129;9593.568289426852;9109.18017378439;9406.1064198901;9497.097775711296;9615.23078153732;9628.566714497725;7443;7607.885881711668;7610.96194519046;7611.733589324347;7613.695452181851;8124;8145;8162.632681529227;8169.101398846241;8174.713885013996;7395;7481.7755467336065;7534.510256833289;7583.355414789805;7638.159802421618;7065.57606543609;7152.070230869954;7280.708771649287;7314.378277846443;7353.411727061929;6826.180858297036;6831.658417079226;6866.725330986705;6880.58716477013;6888.862222755417;5100.540951314251;5201.453847345974;5247.658902171499;5312.601554883322;5361.51578779378;5296.629235953446;5363.919541206963;5390.029794637003;5427.755750991136;5456.372517160577 07:55:35 INFO - PROCESS | 6524 | |4;prototype.html;313.94349017176916;329.4251531078268;330.3788876911406;333.75302276315534;337.8142021887961;5509.779608815647;5545.086945003967;5590.232834746801;5593.496585307322;5594.594324440489;5528.944710552903;5529.612927095105;5544.556435485161;5555;5556.91664625031;4134.7312424692445;4215.988162840927;4261.893452663678;4300.204462174492;4311.655067594601;4327.632151267146;4331.220380331539;4336.501302350239;4340.001799586097;4349.586789255016;4282.357646353041;4294.914101717964;4295.914081718363;4304.677149213806;4309.6336811371075;4150.294449943517;4306.892327691801;4327.134573085364;4334.241507736165;4341.218580655481;3842.7502212356108;3842.865499707497;3853.84584616615;3856.710746693981;3863.4398012288343;5334.519893209591;5375.75809088592;5410.188471729232;5410.242566040757;5422.728863556807;4854.417469903598;4894.241392584155;4963.255511673242;4971.651984361096;4999.3500844890295;5720.71396430181;5753.424657534255;5776.1588543618445;5787.305523337184;5788.623739456922;4161.938705630076;4166.979165104185;4169.187008533338;4175.770332631704;4205.621494065549;5894.911576326359;6007.609505382136;6020.69896505173;6041.275046994345;6043.8186854394;4291.206126866539;4309.784510774449;4310.137972405531;4337.761423121696;4347.391365208873;4396.230659634552;4414.911701765946;4425.690201685851;4429.224885645;4441.733495990251;4877.268409738496;4973.8010479581135;5001.324821149098;5002.724850133205;5027.1956486962645;5831.825045248649;5849.473547380671;5851.268591426072;5853.970730146322;5858.8242352729485;1508.2534145598;1539.5612250508775;1542.8380020097952;1544.5211984284908;1546.4819285539245;963.2005435488528;965.232640051161;983.9704808855746;990.895955924632;1006.2101250518308;5498.725063746877;5651.350094739076;5685.744141513642;5698.287714035746;5709.65742055478;6040.305364883095;6040.395960404012;6055.576109672281;6067.150598916155;6082.482988945989;5533.889322213533;5566.415526369754;5643.194177863044;5654.293213348332;5720.942790572041;3169.4770362889867;3169.7147256746543;3175.4284228839033;3179.8410079495934;3192.6488086310487;5926.821590778491;6152.969235153795;6165.352637973038;6187.907181392283;6217.813465595949;6060.515158787286;6084.878302433926;6087.847803804941;6094.268687757498;6116.724747386378;6155.353687862799;6161.229846269216;6167;6171.352008039091;6221.657808820558;5818.94181058201;5922.674252916131;5937.495312898279;5987.43119403656;5998.1002849572915;5924.259467566554;5930.673812940157;5933.554983376178;5942.58401911862;5953.3153687324775;5952.285725712942;6164.595807635115;6178.845528861814;6212.285587157535;6222.533310001678;4347.9565204347555;4356.956430435655;4360.280553708602;4365.257906155897;4365.672574556857;6015.548833837567;6017.308009578955;6033.396660333931;6042.697865106815;6083.6349819011;5764.769409223584;5827.300723912988;5845.941540584539;5885.234919460443;5886.587938844411;5752.61266574367;5797.2173756542325;5840.94159058404;5851.795187168429;5879;5564.4713752193475;5773.422657734193;5785.074388097884;5814.156947242711;5834.737436815269;5836.686745482232;5840.2115714378015;5862.794802181903;5872.442117998783;5884.029135192645;5728.398518155534;5732.283464566929;5750.5112065474905;5778.422157784188;5823.505002074701 07:55:35 INFO - PROCESS | 6524 | |5;yui.html;834.9123342049088;841.0916210492669;882.435241445475;894.2220268366522;894.3828758156874;17538.73691894621;18248;18349.26602935881;18496.537586560342;18497.35259265926;15989.680206395866;16398.672026559463;16450.670986580262;16486.42297519587;16649.750253746173;868.2966796894519;884.6815146547237;885.7032893980524;886.8004698942718;887.702619622424;697.093778088483;728.5082569265751;854.7051267312767;880.0495464897895;880.7489865388366;937.9577918993627;939.5724945149974;939.6288466055904;940.5109343141562;940.6472572785206;934.9439033658002;936.494293081735;936.7377134402344;936.8735220745181;937.0442149007973;539.6627108057464;564.7571544235977;653.3499168327497;660.4287291492872;678.9796306110775;15858.920705396515;15871.047737135808;15888.523344299689;15899.046057236486;15911.283992220378;15052.849471505255;15178.772318415122;15405.922970385189;15687.137207453585;16344.34622615094;14478.638034049127;14505.202213878232;14708.33812478441;14766.630834229123;15614.609634759108;4816.229403295491;4817.78319975602;4824.662273640846;4941.728204948727;4962.950370496321;80657.59671201665;80945.78581321226;81047.5947620264;81170.59414702888;81342.59328703377;12542;12578.119531632698;12760.80858787119;12813.35933203336;12963.15739476931;21419.250326238507;21834.017469213923;22547.43631409228;22560;22572.435689107577;9403.858942115874;9692.660756873476;9794.118529332394;9813.362131461432;9872.210223182128;4980.078685443204;5032.7735251913755;5050.242463630485;5162.535371816554;5345.599080069011;3521.7358698097746;3692.132348898007;3714.7399682022;3721.5720192177705;3732.7013838893367;623.0436280309702;626.8526896179394;628.1457218183267;638.0333794301637;640.414021170633;721.2282857342593;731.7694926098369;776.2082675670897;799.860024495711;804.6942161978411;10431.16550675944;10668.04919266801;10831.295965762358;10879.401632910265;11019.118470522499;657.1588366890388;697.8046147078826;734.977950661481;738.6565247160096;774.0904437286166;5475.972620136874;5476.644018138808;5624.55003599711;5726.599138060295;5741.971290143522;113898;119374;126988.36505817412;130668;131773.34113329565;74763.25236747671;82005.58997205095;108218;110152;111648;65909.67045164839;74481;99887;101543;101698.49150754198;10286.897131028594;10354.637587684696;10638.14894808398;10841.597761734718;11396.715082123013;56177.438225618855;56201.43798561962;56641;57669;58251.4174858246;82480.58759706163;82627.17372826194;85436.29158400226;85818;86193.56903215444;13395.531156409479;13477.730445391233;13896.722065558835;14121.929390352983;14533.055351402125;15470.303836327617;15484.5354639361;15989.200539972722;16627.750583741494;17833.286668533114;13957.930210348883;14589.197594132425;15001.324940377928;15086.54740357791;16130.919345403667;14511.637209069857;14989.475368362491;15183.620409489851;16288;16402.425915092914;15047.473338433103;15119.697606048037;16156.272967716715;16225.837741622432;16231.756523652391;12250;12363.505459781509;12547.623571292876;12769.10616256853;13319.267440290489;12927.741445171232;13166.210027398387;13212.537561185312;13570.185788852701;13572.321383930961 07:55:35 INFO - PROCESS | 6524 | __end_tp_report 07:55:35 INFO - PROCESS | 6524 | __start_cc_report 07:55:35 INFO - PROCESS | 6524 | _x_x_mozilla_cycle_collect,984 07:55:35 INFO - PROCESS | 6524 | __end_cc_report 07:55:35 INFO - PROCESS | 6524 | __startTimestamp1475247335532__endTimestamp 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | ------- Summary: start ------- 07:55:35 INFO - PROCESS | 6524 | Number of tests: 6 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#0] dojo.html Cycles:165 Average:5488.15 Median:5671.74 stddev:628.57 (11.1%) stddev-sans-first:600.09 07:55:35 INFO - PROCESS | 6524 | Values: 3025.8 3073.5 3096.8 3113.4 3136.9 5414.5 5519.1 5542.9 5549.4 5564.6 5535.4 5565.0 5565.4 5569.0 5579.1 5034.8 5043.9 5083.2 5101.8 5153.4 4885.9 4889.7 5092.0 5139.0 5143.1 4993.1 5002.6 5014.4 5039.4 5049.7 5046.1 5054.3 5114.4 5124.2 5142.9 4770.3 5009.6 5034.7 5065.9 5086.8 5297.1 5404.6 5462.1 5486.1 5496.1 5904.9 5914.9 5989.6 5992.7 6010.9 5644.3 6049.5 6050.2 6058.5 6062.2 5346.4 5514.0 5553.9 5570.0 5615.2 6136.9 6150.3 6150.4 6164.4 6169.6 5602.7 5896.9 5899.8 5906.7 5906.7 5726.9 5749.4 5811.9 5823.0 5823.7 5783.9 5784.8 5790.7 5792.0 5792.8 5825.9 5830.3 5833.4 5868.6 5950.9 4577.2 4580.1 4582.7 4602.6 4603.6 4069.5 4073.0 4116.7 4125.6 4129.7 5387.4 5423.5 5507.9 5562.4 5566.2 5943.1 5944.2 5949.7 5962.4 5987.1 5533.1 5549.1 5608.2 5608.2 5613.7 5043.3 5063.9 5086.0 5129.5 5150.1 5989.7 6069.1 6070.9 6087.5 6108.7 5910.6 5911.2 5915.0 5916.3 5917.3 5926.1 6051.1 6055.5 6061.0 6067.1 5790.5 5835.5 5851.2 5856.5 5928.2 6005.7 6029.0 6035.8 6042.7 6043.3 5904.5 5915.5 5916.3 5923.5 5924.4 5558.9 5671.4 5687.5 5702.7 5716.1 5727.8 5733.0 5739.0 5746.1 5767.9 5750.8 5776.7 5786.3 5792.4 5799.5 5393.1 5477.1 5667.8 5671.7 5677.2 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#1] ext.html Cycles:180 Average:58710.03 Median:38925.51 stddev:114522.65 (294.2%) stddev-sans-first:114760.76 07:55:35 INFO - PROCESS | 6524 | Values: 583.7 601.6 607.0 633.2 640.8 35306.3 35594.0 46559.3 47437.5 47552.8 45042.5 49505.0 49528.0 49531.0 49566.8 9336.2 9459.5 9489.1 9491.0 9507.0 8418.3 8655.2 8657.3 8853.2 10956.4 11105.5 11469.8 11497.4 11499.2 11506.7 11317.7 11367.7 11388.5 11388.9 11390.3 11123.0 11155.7 11167.4 11225.0 11244.0 45815.8 46212.3 46293.5 46316.3 46362.5 3635.2 3741.2 3761.2 4018.9 4209.4 35009.6 35223.1 35424.6 35524.6 35812.3 4690.4 4701.0 4778.2 4782.3 4848.2 259862.0 260972.0 261580.0 261955.0 262185.0 39071.6 64200.4 64288.7 64296.7 64688.4 39353.2 41660.0 41660.8 41734.0 41741.9 17691.5 17861.6 17861.8 17880.0 17886.7 14948.6 15025.2 15028.2 15044.2 15045.8 8880.0 8993.8 9348.4 9539.1 9545.1 3615.1 3625.0 3653.4 3678.0 3715.1 1080.7 1092.3 1095.3 1098.0 1122.9 34326.7 34535.0 34689.3 34742.8 34784.7 1141.3 1143.6 1152.5 1168.7 1179.4 18255.5 18352.3 18362.7 18481.4 18540.8 519884.0 524247.0 524857.0 526191.0 527786.0 61532.0 61883.7 62052.4 62059.4 62232.7 1335.7 1363.2 1374.6 1443.3 1443.7 31613.4 35055.8 36589.8 37319.8 37572.2 57301.0 57804.5 58097.7 58151.7 58195.0 461249.0 461531.0 464682.0 465263.0 466956.0 30978.8 31054.5 31391.5 31650.8 31886.4 42963.8 43666.3 44654.8 45407.1 48499.0 41842.0 42383.4 42883.6 43447.8 43882.8 41812.4 42753.6 42883.1 43398.0 43607.8 41802.2 42164.6 42714.4 42990.1 43176.4 34947.8 37641.4 37875.0 37900.4 38779.4 28401.3 28407.0 28518.1 28592.7 28797.9 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#2] jquery.html Cycles:180 Average:32356.82 Median:2958.26 stddev:87816.77 (2968.5%) stddev-sans-first:88030.33 07:55:35 INFO - PROCESS | 6524 | Values: 393.6 398.7 399.4 401.6 417.6 14754.7 19320.1 20178.2 21195.3 21205.4 15397.5 17535.8 19301.9 19407.6 19938.1 5822.5 6078.8 6083.7 6090.5 6094.5 5531.1 5755.5 5922.5 6013.1 6014.7 5860.5 5871.1 5871.6 5873.2 5874.6 5817.7 5823.6 7055.6 7296.3 7341.0 6978.6 7093.8 7160.2 7227.5 7235.2 26722.9 26963.5 27128.0 27289.3 27740.4 2506.6 2757.5 2793.1 2814.9 3256.6 15760.0 16307.9 16652.5 16707.3 17268.7 2029.3 2055.1 2070.9 2094.7 2101.6 95324.8 97290.5 98877.5 99146.5 101664.5 17477.5 18359.6 18362.4 18529.5 18745.6 32587.7 33651.5 33686.5 33792.3 34303.5 9856.8 10101.3 10352.9 10761.4 11333.9 9138.3 9289.2 9324.5 9526.7 9526.9 8981.6 9322.0 9346.3 9422.0 9460.7 3101.6 3238.8 3361.7 3489.4 3555.8 938.3 974.5 975.3 1013.9 1052.1 19110.9 19429.8 19443.6 19456.5 19970.6 1008.2 1019.3 1027.2 1031.7 1045.9 10620.3 11168.6 11212.9 11300.4 11325.4 520180.0 521982.0 537174.0 541049.0 542186.0 93542.5 94837.0 97617.5 97813.5 102185.0 1039.8 1050.7 1092.3 1095.8 1100.9 17798.4 18088.9 18277.5 18429.5 18638.5 41271.2 44824.3 44964.8 45424.8 46964.0 45565.5 56964.0 58635.0 65116.7 67235.0 8414.5 8560.8 8705.4 8762.5 8875.2 13201.2 13435.0 13656.2 13805.2 14157.2 11822.9 11828.7 11857.6 11924.2 12132.6 11426.9 11640.4 11973.1 11975.1 12028.4 12343.2 12369.7 12377.3 12524.3 12764.2 8556.2 8577.9 8790.0 8885.8 9129.2 9144.6 11385.6 12004.9 12110.3 12465.8 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#3] mootools.html Cycles:180 Average:5543.40 Median:5054.08 stddev:2993.67 (59.2%) stddev-sans-first:2986.64 07:55:35 INFO - PROCESS | 6524 | Values: 1498.7 1516.8 1628.1 1726.3 1755.8 7807.1 8394.3 8394.5 8399.9 8412.0 7317.2 7512.0 7917.2 8074.5 8279.4 2361.3 2381.4 2382.5 2384.0 2385.3 2354.7 2361.4 2405.9 2406.0 2407.0 2074.6 2145.4 2145.9 2152.5 2267.1 2323.6 2352.4 2353.1 2353.4 2357.3 2266.4 2270.4 2270.6 2284.6 2403.1 8120.0 8234.9 8285.7 8312.1 8313.9 4992.0 5112.7 5121.1 5124.4 5133.6 3209.4 3325.4 3327.3 3332.7 3348.1 1126.9 1160.8 1168.3 1174.7 1206.3 10693.8 10953.7 11027.0 11224.5 11315.4 4209.3 4294.0 4432.1 4439.4 4444.9 9055.6 9066.8 9067.7 9070.8 9087.3 5043.9 5045.5 5045.5 5053.4 5054.7 4639.7 4756.0 4765.2 4766.2 4767.4 3712.0 3725.7 3789.0 3844.6 3846.2 1106.4 1119.6 1119.7 1119.7 1122.7 929.3 1039.8 1056.8 1064.5 1068.5 5907.1 5957.0 5984.9 6048.9 6392.8 981.7 992.4 1002.8 1017.4 1022.8 4206.0 4268.7 4333.4 4339.9 4345.8 9800.5 10173.2 10193.1 10204.4 10239.9 10160.3 10177.0 10187.1 10192.4 10212.6 7682.8 7698.0 7731.7 7837.4 7841.0 5760.8 5799.5 5875.6 5880.4 6074.5 9390.2 9464.9 9525.1 9546.2 9593.6 9109.2 9406.1 9497.1 9615.2 9628.6 7443.0 7607.9 7611.0 7611.7 7613.7 8124.0 8145.0 8162.6 8169.1 8174.7 7395.0 7481.8 7534.5 7583.4 7638.2 7065.6 7152.1 7280.7 7314.4 7353.4 6826.2 6831.7 6866.7 6880.6 6888.9 5100.5 5201.5 5247.7 5312.6 5361.5 5296.6 5363.9 5390.0 5427.8 5456.4 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#4] prototype.html Cycles:180 Average:4921.51 Median:5647.27 stddev:1443.71 (25.6%) stddev-sans-first:1405.72 07:55:35 INFO - PROCESS | 6524 | Values: 313.9 329.4 330.4 333.8 337.8 5509.8 5545.1 5590.2 5593.5 5594.6 5528.9 5529.6 5544.6 5555.0 5556.9 4134.7 4216.0 4261.9 4300.2 4311.7 4327.6 4331.2 4336.5 4340.0 4349.6 4282.4 4294.9 4295.9 4304.7 4309.6 4150.3 4306.9 4327.1 4334.2 4341.2 3842.8 3842.9 3853.8 3856.7 3863.4 5334.5 5375.8 5410.2 5410.2 5422.7 4854.4 4894.2 4963.3 4971.7 4999.4 5720.7 5753.4 5776.2 5787.3 5788.6 4161.9 4167.0 4169.2 4175.8 4205.6 5894.9 6007.6 6020.7 6041.3 6043.8 4291.2 4309.8 4310.1 4337.8 4347.4 4396.2 4414.9 4425.7 4429.2 4441.7 4877.3 4973.8 5001.3 5002.7 5027.2 5831.8 5849.5 5851.3 5854.0 5858.8 1508.3 1539.6 1542.8 1544.5 1546.5 963.2 965.2 984.0 990.9 1006.2 5498.7 5651.4 5685.7 5698.3 5709.7 6040.3 6040.4 6055.6 6067.2 6082.5 5533.9 5566.4 5643.2 5654.3 5720.9 3169.5 3169.7 3175.4 3179.8 3192.6 5926.8 6153.0 6165.4 6187.9 6217.8 6060.5 6084.9 6087.8 6094.3 6116.7 6155.4 6161.2 6167.0 6171.4 6221.7 5818.9 5922.7 5937.5 5987.4 5998.1 5924.3 5930.7 5933.6 5942.6 5953.3 5952.3 6164.6 6178.8 6212.3 6222.5 4348.0 4357.0 4360.3 4365.3 4365.7 6015.5 6017.3 6033.4 6042.7 6083.6 5764.8 5827.3 5845.9 5885.2 5886.6 5752.6 5797.2 5840.9 5851.8 5879.0 5564.5 5773.4 5785.1 5814.2 5834.7 5836.7 5840.2 5862.8 5872.4 5884.0 5728.4 5732.3 5750.5 5778.4 5823.5 07:55:35 INFO - PROCESS | 6524 | 07:55:35 INFO - PROCESS | 6524 | [#5] yui.html Cycles:180 Average:22467.46 Median:3606.93 stddev:31745.06 (880.1%) stddev-sans-first:31792.56 07:55:35 INFO - PROCESS | 6524 | Values: 834.9 841.1 882.4 894.2 894.4 17538.7 18248.0 18349.3 18496.5 18497.4 15989.7 16398.7 16450.7 16486.4 16649.8 868.3 884.7 885.7 886.8 887.7 697.1 728.5 854.7 880.0 880.7 938.0 939.6 939.6 940.5 940.6 934.9 936.5 936.7 936.9 937.0 539.7 564.8 653.3 660.4 679.0 15858.9 15871.0 15888.5 15899.0 15911.3 15052.8 15178.8 15405.9 15687.1 16344.3 14478.6 14505.2 14708.3 14766.6 15614.6 4816.2 4817.8 4824.7 4941.7 4963.0 80657.6 80945.8 81047.6 81170.6 81342.6 12542.0 12578.1 12760.8 12813.4 12963.2 21419.3 21834.0 22547.4 22560.0 22572.4 9403.9 9692.7 9794.1 9813.4 9872.2 4980.1 5032.8 5050.2 5162.5 5345.6 3521.7 3692.1 3714.7 3721.6 3732.7 623.0 626.9 628.1 638.0 640.4 721.2 731.8 776.2 799.9 804.7 10431.2 10668.0 10831.3 10879.4 11019.1 657.2 697.8 735.0 738.7 774.1 5476.0 5476.6 5624.6 5726.6 5742.0 113898.0 119374.0 126988.4 130668.0 131773.3 74763.3 82005.6 108218.0 110152.0 111648.0 65909.7 74481.0 99887.0 101543.0 101698.5 10286.9 10354.6 10638.1 10841.6 11396.7 56177.4 56201.4 56641.0 57669.0 58251.4 82480.6 82627.2 85436.3 85818.0 86193.6 13395.5 13477.7 13896.7 14121.9 14533.1 15470.3 15484.5 15989.2 16627.8 17833.3 13957.9 14589.2 15001.3 15086.5 16130.9 14511.6 14989.5 15183.6 16288.0 16402.4 15047.5 15119.7 16156.3 16225.8 16231.8 12250.0 12363.5 12547.6 12769.1 13319.3 12927.7 13166.2 13212.5 13570.2 13572.3 07:55:35 INFO - PROCESS | 6524 | -------- Summary: end -------- 07:55:35 INFO - PROCESS | 6524 | 07:55:36 INFO - TEST-INFO | 6524: exit 0 07:55:36 INFO - TEST-OK | dromaeo_css | took 1114050ms 07:55:36 INFO - TEST-START | kraken 07:55:36 INFO - operating with platform_type : linux_ 07:55:36 INFO - Initialising browser for kraken test... 07:55:36 INFO - TEST-INFO | started process 6842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFiuVt/profile http://localhost:37701/getInfo.html) 07:55:40 INFO - PROCESS | 6842 | __metrics Screen width/height:1600/1200 07:55:40 INFO - PROCESS | 6842 | colorDepth:24 07:55:40 INFO - PROCESS | 6842 | Browser inner width/height: 1024/697 07:55:40 INFO - PROCESS | 6842 | __metrics 07:55:41 INFO - PROCESS | 6842 | 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:41 INFO - PROCESS | 6842 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:41 INFO - PROCESS | 6842 | console.error: PushService: 07:55:41 INFO - PROCESS | 6842 | stateChangeProcessEnqueue: Error transitioning state 07:55:41 INFO - PROCESS | 6842 | UnknownError 07:55:42 INFO - TEST-INFO | 6842: exit 0 07:55:42 INFO - Browser initialized. 07:55:42 INFO - Running cycle 1/1 for kraken test... 07:55:42 INFO - TEST-INFO | started process 6934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFiuVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:53 INFO - PROCESS | 6934 | RSS: Main: 147664896 07:55:53 INFO - PROCESS | 6934 | 07:55:56 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37701/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:57 INFO - PROCESS | 6934 | RSS: Main: 189292544 07:55:57 INFO - PROCESS | 6934 | 07:55:59 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37701/tests/kraken/driver.html?testName=audio-dft) 07:56:00 INFO - PROCESS | 6934 | RSS: Main: 178757632 07:56:00 INFO - PROCESS | 6934 | 07:56:03 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37701/tests/kraken/driver.html?testName=audio-fft) 07:56:03 INFO - PROCESS | 6934 | RSS: Main: 269619200 07:56:03 INFO - PROCESS | 6934 | 07:56:05 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37701/tests/kraken/driver.html?testName=audio-oscillator) 07:56:06 INFO - PROCESS | 6934 | RSS: Main: 176939008 07:56:06 INFO - PROCESS | 6934 | 07:56:08 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:08 INFO - PROCESS | 6934 | RSS: Main: 178126848 07:56:08 INFO - PROCESS | 6934 | 07:56:11 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37701/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:12 INFO - PROCESS | 6934 | RSS: Main: 213872640 07:56:12 INFO - PROCESS | 6934 | 07:56:15 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37701/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:16 INFO - PROCESS | 6934 | RSS: Main: 213282816 07:56:16 INFO - PROCESS | 6934 | 07:56:19 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37701/tests/kraken/driver.html?testName=json-parse-financial) 07:56:19 INFO - PROCESS | 6934 | RSS: Main: 213315584 07:56:19 INFO - PROCESS | 6934 | 07:56:21 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:21 INFO - PROCESS | 6934 | RSS: Main: 174989312 07:56:21 INFO - PROCESS | 6934 | 07:56:23 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:24 INFO - PROCESS | 6934 | RSS: Main: 182677504 07:56:24 INFO - PROCESS | 6934 | 07:56:26 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:26 INFO - PROCESS | 6934 | RSS: Main: 184270848 07:56:26 INFO - PROCESS | 6934 | 07:56:29 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:29 INFO - PROCESS | 6934 | RSS: Main: 185188352 07:56:29 INFO - PROCESS | 6934 | 07:56:32 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:33 INFO - PROCESS | 6934 | RSS: Main: 182652928 07:56:33 INFO - PROCESS | 6934 | 07:56:34 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:37701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37701/tests/kraken/driver.html?testName=ai-astar) 07:56:35 INFO - PROCESS | 6934 | RSS: Main: 234291200 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | __start_tp_report 07:56:35 INFO - PROCESS | 6934 | _x_x_mozilla_page_load 07:56:35 INFO - PROCESS | 6934 | _x_x_mozilla_page_load_details 07:56:35 INFO - PROCESS | 6934 | |i|pagename|runs| 07:56:35 INFO - PROCESS | 6934 | |0;ai-astar;107;112;110;111;112;110;111;111;110;109 07:56:35 INFO - PROCESS | 6934 | |1;audio-beat-detection;141;115;116;156;115;121;116;123;144;116 07:56:35 INFO - PROCESS | 6934 | |2;audio-dft;161;160;162;161;162;160;159;160;163;158 07:56:35 INFO - PROCESS | 6934 | |3;audio-fft;74;75;75;107;74;76;75;74;99;74 07:56:35 INFO - PROCESS | 6934 | |4;audio-oscillator;82;82;114;82;82;82;101;82;81;113 07:56:35 INFO - PROCESS | 6934 | |5;imaging-gaussian-blur;117;117;118;117;117;118;117;117;117;117 07:56:35 INFO - PROCESS | 6934 | |6;imaging-darkroom;146;147;145;145;146;146;146;146;147;147 07:56:35 INFO - PROCESS | 6934 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 07:56:35 INFO - PROCESS | 6934 | |8;json-parse-financial;51;51;48;49;50;53;49;49;49;49 07:56:35 INFO - PROCESS | 6934 | |9;json-stringify-tinderbox;59;60;60;60;59;58;59;59;59;59 07:56:35 INFO - PROCESS | 6934 | |10;stanford-crypto-aes;75;80;82;73;73;73;74;81;72;73 07:56:35 INFO - PROCESS | 6934 | |11;stanford-crypto-ccm;133;117;117;117;115;118;118;115;150;119 07:56:35 INFO - PROCESS | 6934 | |12;stanford-crypto-pbkdf2;154;153;153;154;151;155;150;153;151;153 07:56:35 INFO - PROCESS | 6934 | |13;stanford-crypto-sha256-iterative;61;62;63;63;61;64;61;62;60;60 07:56:35 INFO - PROCESS | 6934 | __end_tp_report 07:56:35 INFO - PROCESS | 6934 | __start_cc_report 07:56:35 INFO - PROCESS | 6934 | _x_x_mozilla_cycle_collect,1552 07:56:35 INFO - PROCESS | 6934 | __end_cc_report 07:56:35 INFO - PROCESS | 6934 | __startTimestamp1475247395085__endTimestamp 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | ------- Summary: start ------- 07:56:35 INFO - PROCESS | 6934 | Number of tests: 14 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:1.00 07:56:35 INFO - PROCESS | 6934 | Values: 107.0 112.0 110.0 111.0 112.0 110.0 111.0 111.0 110.0 109.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:122.00 stddev:15.00 (12.3%) stddev-sans-first:14.93 07:56:35 INFO - PROCESS | 6934 | Values: 141.0 115.0 116.0 156.0 115.0 121.0 116.0 123.0 144.0 116.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 07:56:35 INFO - PROCESS | 6934 | Values: 161.0 160.0 162.0 161.0 162.0 160.0 159.0 160.0 163.0 158.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:12.13 (16.2%) stddev-sans-first:12.65 07:56:35 INFO - PROCESS | 6934 | Values: 74.0 75.0 75.0 107.0 74.0 76.0 75.0 74.0 99.0 74.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.71 (16.7%) stddev-sans-first:14.22 07:56:35 INFO - PROCESS | 6934 | Values: 82.0 82.0 114.0 82.0 82.0 82.0 101.0 82.0 81.0 113.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:56:35 INFO - PROCESS | 6934 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 07:56:35 INFO - PROCESS | 6934 | Values: 146.0 147.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 147.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:56:35 INFO - PROCESS | 6934 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.50 stddev:1.48 (3.0%) stddev-sans-first:1.50 07:56:35 INFO - PROCESS | 6934 | Values: 51.0 51.0 48.0 49.0 50.0 53.0 49.0 49.0 49.0 49.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 07:56:35 INFO - PROCESS | 6934 | Values: 59.0 60.0 60.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:3.84 (5.1%) stddev-sans-first:4.06 07:56:35 INFO - PROCESS | 6934 | Values: 75.0 80.0 82.0 73.0 73.0 73.0 74.0 81.0 72.0 73.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:118.00 stddev:11.15 (9.4%) stddev-sans-first:11.08 07:56:35 INFO - PROCESS | 6934 | Values: 133.0 117.0 117.0 117.0 115.0 118.0 118.0 115.0 150.0 119.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:153.00 stddev:1.57 (1.0%) stddev-sans-first:1.59 07:56:35 INFO - PROCESS | 6934 | Values: 154.0 153.0 153.0 154.0 151.0 155.0 150.0 153.0 151.0 153.0 07:56:35 INFO - PROCESS | 6934 | 07:56:35 INFO - PROCESS | 6934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.39 07:56:35 INFO - PROCESS | 6934 | Values: 61.0 62.0 63.0 63.0 61.0 64.0 61.0 62.0 60.0 60.0 07:56:35 INFO - PROCESS | 6934 | -------- Summary: end -------- 07:56:35 INFO - PROCESS | 6934 | 07:56:36 INFO - TEST-INFO | 6934: exit 0 07:56:36 INFO - TEST-OK | kraken | took 59807ms 07:56:36 INFO - SUITE-END | took 1173s 07:56:36 INFO - Completed test suite (00:19:33) 07:56:36 INFO - javascript benchmark 07:56:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.8335791531467, 3073.4775088235006, 3096.7522598192163, 3113.4084523940437, 3136.8902088426908, 5414.512693857557, 5519.06175950088, 5542.944570554293, 5549.38956714761, 5564.554835613151, 5535.363433205172, 5565.0, 5565.3878073412, 5569.0254205513975, 5579.13523403872, 5034.798608055683, 5043.924341134886, 5083.18669012958, 5101.84694459165, 5153.381594208681, 4885.8778530536665, 4889.7066176029375, 5091.974540127294, 5139.0, 5143.099957507421, 4993.051320249159, 5002.649814512985, 5014.373203349582, 5039.420466646346, 5049.67177133487, 5046.066477701637, 5054.292399064152, 5114.411842638107, 5124.15451450514, 5142.897142057138, 4770.260609605517, 5009.624278179152, 5034.697918124888, 5065.873353166164, 5086.79652813887, 5297.12597421425, 5404.648697834628, 5462.071447853835, 5486.067368547317, 5496.148097044965, 5904.852378690524, 5914.940850591482, 5989.55078369124, 5992.700364981733, 6010.909836352458, 5644.322681278273, 6049.455549000611, 6050.183225264577, 6058.454739073461, 6062.242219722535, 5346.385165705916, 5514.0, 5553.916691249635, 5570.0, 5615.18579805934, 6136.9079463808075, 6150.323464418911, 6150.354212807591, 6164.4143806338325, 6169.629822210682, 5602.663840169603, 5896.911546326808, 5899.764009439575, 5906.704664766745, 5906.734196961147, 5726.885462290731, 5749.3963133871175, 5811.88376232473, 5823.010088285002, 5823.679697616672, 5783.88432231353, 5784.82645520635, 5790.739416726257, 5792.044312688444, 5792.768289268466, 5825.912611310834, 5830.329512106077, 5833.358330583633, 5868.589198756132, 5950.851228719317, 4577.176108300471, 4580.129775342674, 4582.725036497821, 4602.631789456836, 4603.58567728906, 4069.4506241656995, 4072.9796351018053, 4116.6912481564, 4125.608067233668, 4129.69027322952, 5387.4073851876265, 5423.538999185034, 5507.917381239285, 5562.360328562187, 5566.2207290979295, 5943.108533719977, 5944.227250457413, 5949.732262048218, 5962.433568810956, 5987.072003839412, 5533.142362933751, 5549.084401073858, 5608.158776183605, 5608.242887210175, 5613.663180209201, 5043.3191519145175, 5063.87340316495, 5086.0, 5129.461406552333, 5150.072986862326, 5989.700514974234, 6069.089636554552, 6070.9089363658695, 6087.512998960073, 6108.694565271719, 5910.61580997251, 5911.231539899785, 5914.994450943436, 5916.3492015877355, 5917.260342457193, 5926.111083337534, 6051.092336149437, 6055.485283750931, 6061.0, 6067.120267561268, 5790.478856902899, 5835.503982161564, 5851.239338885917, 5856.472917437451, 5928.170056192051, 6005.699715014319, 6029.035354343284, 6035.818925432244, 6042.697865106639, 6043.2748070231855, 5904.468597826216, 5915.526757859447, 5916.349201587908, 5923.466887980103, 5924.377940316377, 5558.916616250679, 5671.432856714296, 5687.488126068673, 5702.714864256687, 5716.085426331767, 5727.799527016535, 5733.0, 5739.0, 5746.13807928814, 5767.913481297868, 5750.827475175752, 5776.740046697824, 5786.276715410574, 5792.362840087502, 5799.536037117105, 5393.083175860034, 5477.068898287381, 5667.801626943202, 5671.744771485375, 5677.176809362537], "value": 5444.83953627554, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6935608805377, 601.6149664214902, 606.9544784141187, 633.1547384242036, 640.8461969127411, 35306.2938741225, 35594.0, 46559.30161047587, 47437.52562474374, 47552.76223618877, 45042.54957450424, 49505.0, 49528.0, 49531.0, 49566.752166239115, 9336.159745622892, 9459.527023648825, 9489.14597686208, 9490.952545237264, 9506.952465237664, 8418.326533877274, 8655.221030107288, 8657.307415406753, 8853.24747396472, 10956.397398143099, 11105.500252488617, 11469.770604587946, 11497.447844540964, 11499.19505634606, 11506.654800356002, 11317.717057073598, 11367.715807104805, 11388.487518061624, 11388.886111138949, 11390.316581005167, 11123.0, 11155.721106972309, 11167.441627918653, 11225.0, 11244.0, 45815.77092114518, 46212.306815397795, 46293.53706462926, 46316.3052554212, 46362.53637463616, 3635.1820840310984, 3741.2143449875557, 3761.153740408414, 4018.9397159042637, 4209.431726716884, 35009.6499035009, 35223.119422014395, 35424.64575354265, 35524.64475355239, 35812.28375432503, 4690.366800481926, 4700.952990470086, 4778.235482322846, 4782.33047373368, 4848.17581011229, 259862.0, 260971.9999999981, 261580.0, 261955.0, 262185.0, 39071.60928390737, 64200.357996420375, 64288.678556606916, 64296.67851660805, 64688.353116469174, 39353.2129357417, 41660.0, 41660.79169604193, 41734.0, 41741.91290435466, 17691.469255922344, 17861.553461163316, 17861.821381786016, 17880.0, 17886.731699024524, 14948.626284342978, 15025.173615451036, 15028.248587570577, 15044.172570508508, 15045.774313385307, 8880.0, 8993.820123597623, 9348.392354496937, 9539.14147726708, 9545.093216144454, 3615.1142969972525, 3625.0, 3653.415453527423, 3678.043708635774, 3715.108373990277, 1080.6649938519083, 1092.2790957967702, 1095.3427943233996, 1097.9725506862392, 1122.8652561692486, 34326.65673343284, 34535.0, 34689.30621387558, 34742.82628586841, 34784.65215347814, 1141.2581821815886, 1143.6111722014389, 1152.5101831721486, 1168.7311918258847, 1179.3572502985894, 18255.54361140982, 18352.265909363476, 18362.724559131624, 18481.353152639593, 18540.814591854178, 519884.0, 524247.0, 524857.0, 526191.0, 527786.0, 61532.0, 61883.690581546805, 62052.37947620466, 62059.379406206266, 62232.68883655553, 1335.6660834791303, 1363.16165558181, 1374.6494643865751, 1443.3288520837862, 1443.6535231544565, 31613.367732644758, 35055.82472087623, 36589.81705091458, 37319.81340093282, 37572.2485550282, 57301.0, 57804.53172809645, 58097.70951145217, 58151.70924145352, 58195.0, 461249.0, 461531.0, 464682.0, 465263.0, 466956.0, 30978.845105774326, 31054.53418198774, 31391.529127063568, 31650.841745792044, 31886.36227275488, 42963.785181075145, 43666.34500482559, 44654.776726116164, 45407.091858163316, 48499.0, 41842.0, 42383.36424953566, 42883.56188282903, 43447.78276108599, 43882.78058609814, 41812.372814408416, 42753.5724642762, 42883.14233715371, 43398.0, 43607.78196109126, 41802.163956720084, 42164.578354216064, 42714.359284611375, 42990.14019719526, 43176.35235471408, 34947.825260873535, 37641.4353784688, 37875.0, 37900.43149352707, 38779.418308724824, 28401.28996775097, 28407.0, 28518.144455665533, 28592.714072859006, 28797.856010719814], "value": 20289.479053016377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.5867339293741, 398.6750798099547, 399.40688078203874, 401.62448111016204, 417.5824175824176, 14754.704905901875, 19320.130594123264, 20178.192872285126, 21195.258165964176, 21205.363839084832, 15397.538073857775, 17535.824641753577, 19301.903490482564, 19407.611847763037, 19938.102785374656, 5822.475977162055, 6078.848028799272, 6083.695815209244, 6090.512758979271, 6094.451499365056, 5531.1426728857095, 5755.453231942959, 5922.466977971982, 6013.128096426016, 6014.669193194372, 5860.53115750741, 5871.148683440899, 5871.588988770766, 5873.177755114288, 5874.588778785486, 5817.650940943536, 5823.592348535604, 7055.576665400093, 7296.343329100407, 7341.008963789874, 6978.581285122909, 7093.751718689873, 7160.248173941765, 7227.457940654419, 7235.240299768554, 26722.86638566814, 26963.46073078547, 27128.0, 27289.317767055785, 27740.445191096063, 2506.5738824399896, 2757.489864375097, 2793.1201671473623, 2814.8874045038174, 3256.641769405387, 15760.0, 16307.91846040774, 16652.50042498727, 16707.331706731715, 17268.740968885475, 2029.3100345882472, 2055.0649454498166, 2070.8653937494014, 2094.675325324577, 2101.63221436248, 95324.80388774707, 97290.51354743252, 98877.5056124722, 99146.5042674782, 101664.49167754114, 17477.475675729747, 18359.61325027738, 18362.35731749409, 18529.53676158107, 18745.625087498174, 32587.674123258937, 33651.495227571606, 33686.49470257948, 33792.32415351679, 34303.4854477183, 9856.753581160385, 10101.292909496266, 10352.948235258775, 10761.354318740901, 11333.943330283295, 9138.268938484905, 9289.163975242125, 9324.487153206639, 9526.714198574055, 9526.904730952601, 8981.550922453851, 9322.0, 9346.252299815998, 9421.952890235505, 9460.675505429246, 3101.6278046634548, 3238.757093217971, 3361.6638336166675, 3489.4242449995972, 3555.7510974232073, 938.3103418987039, 974.4591751577942, 975.3075316525204, 1013.9340942838692, 1052.084686322904, 19110.90444547796, 19429.80570194308, 19443.611127777363, 19456.513587160433, 19970.60058798816, 1008.1732978957331, 1019.2610357490908, 1027.2398425165325, 1031.7369070886875, 1045.9006394392673, 10620.309679870783, 11168.609098681507, 11212.887871121347, 11300.378479183724, 11325.377104259345, 520180.0, 521982.0, 537174.0, 541049.0, 542186.0, 93542.53228733812, 94837.0, 97617.5119124414, 97813.51093244489, 102185.0, 1039.8284283093205, 1050.7373156710823, 1092.322759888874, 1095.8301463273206, 1100.8568886044764, 17798.37705680295, 18088.909555452137, 18277.54306142357, 18429.53926151803, 18638.53403664919, 41271.1745765089, 44824.32763508485, 44964.77517612391, 45424.77287613541, 46964.0, 45565.54434455746, 56964.0, 58635.0, 65116.67441662761, 67235.0, 8414.495130292202, 8560.828783424422, 8705.390622656354, 8762.518061506678, 8875.245604123464, 13201.20792752438, 13435.0, 13656.248906309851, 13805.17168969865, 14157.150570965776, 11822.881771182178, 11828.70428239301, 11857.5849845255, 11924.165308428326, 12132.636020919386, 11426.885731142915, 11640.417979101181, 11973.10201734856, 11975.101867360157, 12028.398580070787, 12343.19769214998, 12369.690757730768, 12377.257364558156, 12524.311162885764, 12764.17032892859, 8556.18716221958, 8577.871331930151, 8790.033096359522, 8885.777855553662, 9129.178373946377, 9144.63421463134, 11385.601503947322, 12004.939975300067, 12110.333931633844, 12465.813012804996], "value": 10609.351801522282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.7452133137365, 1516.848315168483, 1628.080134723881, 1726.33536088606, 1755.8331958463941, 7807.102183248928, 8394.328453723703, 8394.454360466572, 8399.91600083999, 8412.0, 7317.158526769423, 7511.962440187805, 7917.247861453167, 8074.515529068245, 8279.379046571516, 2361.3034154924294, 2381.416552944531, 2382.5473160099527, 2384.0, 2385.320183747632, 2354.6703461515403, 2361.3624321433203, 2405.915792947247, 2405.9639105413435, 2407.0492155598527, 2074.605824893273, 2145.3778404262744, 2145.9356219313368, 2152.45112496314, 2267.0591704442636, 2323.604987152188, 2352.447174913894, 2353.0940587873706, 2353.3998830298165, 2357.3045951444365, 2266.444721043355, 2270.3529494094105, 2270.648049552322, 2284.6116160252795, 2403.062805505854, 8120.0, 8234.876476852853, 8285.668573257062, 8312.127226641236, 8313.875291870627, 4992.0, 5112.667676601046, 5121.078205922932, 5124.410692770304, 5133.640645154841, 3209.3741720364537, 3325.418051840918, 3327.2680010397917, 3332.683395077464, 3348.11275012122, 1126.9042131418757, 1160.79105760963, 1168.263993683982, 1174.6593487888501, 1206.2641788509002, 10693.83959240612, 10953.726156846064, 11027.00756931872, 11224.494897729623, 11315.434228288635, 4209.284421648327, 4294.0, 4432.069265454226, 4439.4006809080365, 4444.933326000112, 9055.59249833759, 9066.773330666654, 9067.68263110788, 9070.81858362829, 9087.273018158532, 5043.924341134886, 5045.495450454925, 5045.495450454925, 5053.418856831438, 5054.7472626368535, 4639.721616703008, 4755.95244047562, 4765.1660959331975, 4766.237402015661, 4767.404074490689, 3711.9628803711616, 3725.683316918038, 3789.033796381905, 3844.6347596978244, 3846.2307538492414, 1106.3583121789343, 1119.6137332620233, 1119.7144728094283, 1119.7424592343643, 1122.7137080044536, 929.2612373163352, 1039.7972395382978, 1056.7886422715335, 1064.494365176535, 1068.5084860963889, 5907.1139329100115, 5957.0, 5984.850378740566, 6048.909266361008, 6392.808215753535, 981.7202097402206, 992.4442312305132, 1002.7844013536978, 1017.4200705597887, 1022.754538910656, 4205.957940420618, 4268.722533035343, 4333.414988976511, 4339.869803905888, 4345.804438800262, 9800.509974501247, 10173.23700722434, 10193.133583645473, 10204.38773673582, 10239.948800255952, 10160.33957792741, 10177.03318184786, 10187.08316251526, 10192.388456692473, 10212.591496340212, 7682.769516914502, 7698.0, 7731.729389471341, 7837.37301015906, 7841.0, 5760.8271751847515, 5799.5070419014855, 5875.588708790344, 5880.382559831156, 6074.453299203093, 9390.154886060287, 9464.905350946678, 9525.095115963972, 9546.18857397129, 9593.568289426852, 9109.18017378439, 9406.1064198901, 9497.097775711296, 9615.23078153732, 9628.566714497725, 7443.0, 7607.885881711668, 7610.96194519046, 7611.733589324347, 7613.695452181851, 8124.0, 8145.0, 8162.632681529227, 8169.101398846241, 8174.713885013996, 7395.0, 7481.7755467336065, 7534.510256833289, 7583.355414789805, 7638.159802421618, 7065.57606543609, 7152.070230869954, 7280.708771649287, 7314.378277846443, 7353.411727061929, 6826.180858297036, 6831.658417079226, 6866.725330986705, 6880.58716477013, 6888.862222755417, 5100.540951314251, 5201.453847345974, 5247.658902171499, 5312.601554883322, 5361.51578779378, 5296.629235953446, 5363.919541206963, 5390.029794637003, 5427.755750991136, 5456.372517160577], "value": 4515.868516994607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.94349017176916, 329.4251531078268, 330.3788876911406, 333.75302276315534, 337.8142021887961, 5509.779608815647, 5545.086945003967, 5590.232834746801, 5593.496585307322, 5594.594324440489, 5528.944710552903, 5529.612927095105, 5544.556435485161, 5555.0, 5556.91664625031, 4134.7312424692445, 4215.988162840927, 4261.893452663678, 4300.204462174492, 4311.655067594601, 4327.632151267146, 4331.220380331539, 4336.501302350239, 4340.001799586097, 4349.586789255016, 4282.357646353041, 4294.914101717964, 4295.914081718363, 4304.677149213806, 4309.6336811371075, 4150.294449943517, 4306.892327691801, 4327.134573085364, 4334.241507736165, 4341.218580655481, 3842.7502212356108, 3842.865499707497, 3853.84584616615, 3856.710746693981, 3863.4398012288343, 5334.519893209591, 5375.75809088592, 5410.188471729232, 5410.242566040757, 5422.728863556807, 4854.417469903598, 4894.241392584155, 4963.255511673242, 4971.651984361096, 4999.3500844890295, 5720.71396430181, 5753.424657534255, 5776.1588543618445, 5787.305523337184, 5788.623739456922, 4161.938705630076, 4166.979165104185, 4169.187008533338, 4175.770332631704, 4205.621494065549, 5894.911576326359, 6007.609505382136, 6020.69896505173, 6041.275046994345, 6043.8186854394, 4291.206126866539, 4309.784510774449, 4310.137972405531, 4337.761423121696, 4347.391365208873, 4396.230659634552, 4414.911701765946, 4425.690201685851, 4429.224885645, 4441.733495990251, 4877.268409738496, 4973.8010479581135, 5001.324821149098, 5002.724850133205, 5027.1956486962645, 5831.825045248649, 5849.473547380671, 5851.268591426072, 5853.970730146322, 5858.8242352729485, 1508.2534145598, 1539.5612250508775, 1542.8380020097952, 1544.5211984284908, 1546.4819285539245, 963.2005435488528, 965.232640051161, 983.9704808855746, 990.895955924632, 1006.2101250518308, 5498.725063746877, 5651.350094739076, 5685.744141513642, 5698.287714035746, 5709.65742055478, 6040.305364883095, 6040.395960404012, 6055.576109672281, 6067.150598916155, 6082.482988945989, 5533.889322213533, 5566.415526369754, 5643.194177863044, 5654.293213348332, 5720.942790572041, 3169.4770362889867, 3169.7147256746543, 3175.4284228839033, 3179.8410079495934, 3192.6488086310487, 5926.821590778491, 6152.969235153795, 6165.352637973038, 6187.907181392283, 6217.813465595949, 6060.515158787286, 6084.878302433926, 6087.847803804941, 6094.268687757498, 6116.724747386378, 6155.353687862799, 6161.229846269216, 6167.0, 6171.352008039091, 6221.657808820558, 5818.94181058201, 5922.674252916131, 5937.495312898279, 5987.43119403656, 5998.1002849572915, 5924.259467566554, 5930.673812940157, 5933.554983376178, 5942.58401911862, 5953.3153687324775, 5952.285725712942, 6164.595807635115, 6178.845528861814, 6212.285587157535, 6222.533310001678, 4347.9565204347555, 4356.956430435655, 4360.280553708602, 4365.257906155897, 4365.672574556857, 6015.548833837567, 6017.308009578955, 6033.396660333931, 6042.697865106815, 6083.6349819011, 5764.769409223584, 5827.300723912988, 5845.941540584539, 5885.234919460443, 5886.587938844411, 5752.61266574367, 5797.2173756542325, 5840.94159058404, 5851.795187168429, 5879.0, 5564.4713752193475, 5773.422657734193, 5785.074388097884, 5814.156947242711, 5834.737436815269, 5836.686745482232, 5840.2115714378015, 5862.794802181903, 5872.442117998783, 5884.029135192645, 5728.398518155534, 5732.283464566929, 5750.5112065474905, 5778.422157784188, 5823.505002074701], "value": 4454.858789533019, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.9123342049088, 841.0916210492669, 882.435241445475, 894.2220268366522, 894.3828758156874, 17538.73691894621, 18248.0, 18349.26602935881, 18496.537586560342, 18497.35259265926, 15989.680206395866, 16398.672026559463, 16450.670986580262, 16486.42297519587, 16649.750253746173, 868.2966796894519, 884.6815146547237, 885.7032893980524, 886.8004698942718, 887.702619622424, 697.093778088483, 728.5082569265751, 854.7051267312767, 880.0495464897895, 880.7489865388366, 937.9577918993627, 939.5724945149974, 939.6288466055904, 940.5109343141562, 940.6472572785206, 934.9439033658002, 936.494293081735, 936.7377134402344, 936.8735220745181, 937.0442149007973, 539.6627108057464, 564.7571544235977, 653.3499168327497, 660.4287291492872, 678.9796306110775, 15858.920705396515, 15871.047737135808, 15888.523344299689, 15899.046057236486, 15911.283992220378, 15052.849471505255, 15178.772318415122, 15405.922970385189, 15687.137207453585, 16344.34622615094, 14478.638034049127, 14505.202213878232, 14708.33812478441, 14766.630834229123, 15614.609634759108, 4816.229403295491, 4817.78319975602, 4824.662273640846, 4941.728204948727, 4962.950370496321, 80657.59671201665, 80945.78581321226, 81047.5947620264, 81170.59414702888, 81342.59328703377, 12542.0, 12578.119531632698, 12760.80858787119, 12813.35933203336, 12963.15739476931, 21419.250326238507, 21834.017469213923, 22547.43631409228, 22560.0, 22572.435689107577, 9403.858942115874, 9692.660756873476, 9794.118529332394, 9813.362131461432, 9872.210223182128, 4980.078685443204, 5032.7735251913755, 5050.242463630485, 5162.535371816554, 5345.599080069011, 3521.7358698097746, 3692.132348898007, 3714.7399682022, 3721.5720192177705, 3732.7013838893367, 623.0436280309702, 626.8526896179394, 628.1457218183267, 638.0333794301637, 640.414021170633, 721.2282857342593, 731.7694926098369, 776.2082675670897, 799.860024495711, 804.6942161978411, 10431.16550675944, 10668.04919266801, 10831.295965762358, 10879.401632910265, 11019.118470522499, 657.1588366890388, 697.8046147078826, 734.977950661481, 738.6565247160096, 774.0904437286166, 5475.972620136874, 5476.644018138808, 5624.55003599711, 5726.599138060295, 5741.971290143522, 113898.0, 119374.0, 126988.36505817412, 130668.0, 131773.34113329565, 74763.25236747671, 82005.58997205095, 108218.0, 110152.0, 111648.0, 65909.67045164839, 74481.0, 99887.0, 101543.0, 101698.49150754198, 10286.897131028594, 10354.637587684696, 10638.14894808398, 10841.597761734718, 11396.715082123013, 56177.438225618855, 56201.43798561962, 56641.0, 57669.0, 58251.4174858246, 82480.58759706163, 82627.17372826194, 85436.29158400226, 85818.0, 86193.56903215444, 13395.531156409479, 13477.730445391233, 13896.722065558835, 14121.929390352983, 14533.055351402125, 15470.303836327617, 15484.5354639361, 15989.200539972722, 16627.750583741494, 17833.286668533114, 13957.930210348883, 14589.197594132425, 15001.324940377928, 15086.54740357791, 16130.919345403667, 14511.637209069857, 14989.475368362491, 15183.620409489851, 16288.0, 16402.425915092914, 15047.473338433103, 15119.697606048037, 16156.272967716715, 16225.837741622432, 16231.756523652391, 12250.0, 12363.505459781509, 12547.623571292876, 12769.10616256853, 13319.267440290489, 12927.741445171232, 13166.210027398387, 13212.537561185312, 13570.185788852701, 13572.321383930961], "value": 8301.413026130436, "unit": "score"}], "name": "dromaeo_css", "value": 7619.965950974539, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 110.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 116.0, 156.0, 115.0, 121.0, 116.0, 123.0, 144.0, 116.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 160.0, 159.0, 160.0, 163.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 74.0, 76.0, 75.0, 74.0, 99.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 82.0, 82.0, 82.0, 101.0, 82.0, 81.0, 113.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 48.0, 49.0, 50.0, 53.0, 49.0, 49.0, 49.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 82.0, 73.0, 73.0, 73.0, 74.0, 81.0, 72.0, 73.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 117.0, 117.0, 117.0, 115.0, 118.0, 118.0, 115.0, 150.0, 119.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 153.0, 154.0, 151.0, 155.0, 150.0, 153.0, 151.0, 153.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 61.0, 64.0, 61.0, 62.0, 60.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1446.7, "alertThreshold": 2.0}]} 07:56:36 INFO - Return code: 0 07:56:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:36 INFO - # TBPL SUCCESS # 07:56:36 INFO - Running post-action listener: _resource_record_post_action 07:56:36 INFO - [mozharness: 2016-09-30 14:56:36.379326Z] Finished run-tests step (success) 07:56:36 INFO - Running post-run listener: _resource_record_post_run 07:56:36 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2494464; Write bytes: 368353280; Read time: 112; Write time: 276124 07:56:36 INFO - TinderboxPrint: CPU usage
12.9% 07:56:36 INFO - TinderboxPrint: I/O read bytes / time
2,494,464 / 112 07:56:36 INFO - TinderboxPrint: I/O write bytes / time
368,353,280 / 276,124 07:56:36 INFO - TinderboxPrint: CPU idle
8,268.1 (87.1%) 07:56:36 INFO - TinderboxPrint: CPU user
1,185.5 (12.5%) 07:56:36 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118714368; Read time: 0; Write time: 90132 07:56:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 757760; Write bytes: 249638912; Read time: 68; Write time: 185992 07:56:36 INFO - Running post-run listener: _upload_blobber_files 07:56:36 INFO - Blob upload gear active. 07:56:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:36 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:36 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:36 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:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:38 INFO - (blobuploader) - INFO - Done attempting. 07:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:41 INFO - (blobuploader) - INFO - Done attempting. 07:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:42 INFO - (blobuploader) - INFO - Done attempting. 07:56:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:42 INFO - Return code: 0 07:56:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de384521b456a254da1629b257bb25138538efacaad5d7a740cd251ccb79ddb26e8d048ee6550a740b05e82cce513546bb92e327cf4a8f40cfcd538f22d52f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e59e34d749d40bce1ad217e751bb5a13f4d9333cd235252190b74f6ce4bf1b2dd3be8ed8f223c3507a7c6f1d810d065bc4009793e91dedd49c035a89e876efa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83c65a4797b9e2633d443ff1becadcaa6270663ffabb0833a9470bd370a3f39bc8d8ce202c7c874fcd0c11e3a20b972584a433deb610baaded35d0e42ae12fc2"} 07:56:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:42 INFO - Contents: 07:56:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de384521b456a254da1629b257bb25138538efacaad5d7a740cd251ccb79ddb26e8d048ee6550a740b05e82cce513546bb92e327cf4a8f40cfcd538f22d52f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e59e34d749d40bce1ad217e751bb5a13f4d9333cd235252190b74f6ce4bf1b2dd3be8ed8f223c3507a7c6f1d810d065bc4009793e91dedd49c035a89e876efa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83c65a4797b9e2633d443ff1becadcaa6270663ffabb0833a9470bd370a3f39bc8d8ce202c7c874fcd0c11e3a20b972584a433deb610baaded35d0e42ae12fc2"} 07:56:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:42 INFO - Copying logs to upload dir... 07:56:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.697015 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-30 07:56:42.435618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:42.443103) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 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/de384521b456a254da1629b257bb25138538efacaad5d7a740cd251ccb79ddb26e8d048ee6550a740b05e82cce513546bb92e327cf4a8f40cfcd538f22d52f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e59e34d749d40bce1ad217e751bb5a13f4d9333cd235252190b74f6ce4bf1b2dd3be8ed8f223c3507a7c6f1d810d065bc4009793e91dedd49c035a89e876efa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83c65a4797b9e2633d443ff1becadcaa6270663ffabb0833a9470bd370a3f39bc8d8ce202c7c874fcd0c11e3a20b972584a433deb610baaded35d0e42ae12fc2"} 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.011806 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/de384521b456a254da1629b257bb25138538efacaad5d7a740cd251ccb79ddb26e8d048ee6550a740b05e82cce513546bb92e327cf4a8f40cfcd538f22d52f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e59e34d749d40bce1ad217e751bb5a13f4d9333cd235252190b74f6ce4bf1b2dd3be8ed8f223c3507a7c6f1d810d065bc4009793e91dedd49c035a89e876efa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83c65a4797b9e2633d443ff1becadcaa6270663ffabb0833a9470bd370a3f39bc8d8ce202c7c874fcd0c11e3a20b972584a433deb610baaded35d0e42ae12fc2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:42.471405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:42.471743) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475243468.446501-1149242238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:42.521384) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:42.524713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:42.524998) ========= ========= Total master_lag: 0.35 =========