builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1479126061.49 results: success (0) buildid: 20161114013321 builduid: 4a12ef8c63a34fc8b847622d02cb6a4f revision: 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.491380) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.491807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.492135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.552138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.552439) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 04:21:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-11-14 04:21:02 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.651654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.651963) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020476 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.712234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:01.712892) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 --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 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 04:21:02,290 truncating revision to first 12 chars 2016-11-14 04:21:02,290 Setting DEBUG logging. 2016-11-14 04:21:02,290 attempt 1/10 2016-11-14 04:21:02,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3b68ca65557a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 04:21:02,610 unpacking tar archive at: mozilla-aurora-3b68ca65557a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:02.410617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:02.411262) ========= script_repo_revision: 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:02.412152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:02.412774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 04:21:02.423819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 04:21:02.424141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:03 INFO - MultiFileLogger online at 20161114 04:21:03 in /builds/slave/test 04:21:03 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 04:21:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:03 INFO - {'append_to_log': False, 04:21:03 INFO - 'base_work_dir': '/builds/slave/test', 04:21:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:21:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:03 INFO - 'branch': 'Mozilla-Aurora', 04:21:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:03 INFO - 'config_files': ('talos/linux_config.py',), 04:21:03 INFO - 'default_actions': ('clobber', 04:21:03 INFO - 'read-buildbot-config', 04:21:03 INFO - 'download-and-extract', 04:21:03 INFO - 'populate-webroot', 04:21:03 INFO - 'create-virtualenv', 04:21:03 INFO - 'install', 04:21:03 INFO - 'run-tests'), 04:21:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:03 INFO - 'download_minidump_stackwalk': True, 04:21:03 INFO - 'download_symbols': 'ondemand', 04:21:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:03 INFO - 'installer_path': 'installer.exe', 04:21:03 INFO - 'log_level': 'info', 04:21:03 INFO - 'log_name': 'talos', 04:21:03 INFO - 'log_to_console': True, 04:21:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:03 INFO - 'opt_config_files': (), 04:21:03 INFO - 'pip_index': False, 04:21:03 INFO - 'sps_profile': False, 04:21:03 INFO - 'sps_profile_interval': 0, 04:21:03 INFO - 'suite': 'dromaeojs', 04:21:03 INFO - 'system_bits': '32', 04:21:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:03 INFO - 'title': 'talos-linux64-ix-069', 04:21:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:03 INFO - 'use_talos_json': True, 04:21:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:03 INFO - 'work_dir': 'build'} 04:21:03 INFO - [mozharness: 2016-11-14 12:21:03.091646Z] Running clobber step. 04:21:03 INFO - Running pre-action listener: _resource_record_pre_action 04:21:03 INFO - Running main action method: clobber 04:21:03 INFO - rmtree: /builds/slave/test/build 04:21:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:03 INFO - Running post-action listener: _resource_record_post_action 04:21:03 INFO - [mozharness: 2016-11-14 12:21:03.542922Z] Finished clobber step (success) 04:21:03 INFO - [mozharness: 2016-11-14 12:21:03.543024Z] Running read-buildbot-config step. 04:21:03 INFO - Running pre-action listener: _resource_record_pre_action 04:21:03 INFO - Running main action method: read_buildbot_config 04:21:03 INFO - Using buildbot properties: 04:21:03 INFO - { 04:21:03 INFO - "project": "", 04:21:03 INFO - "product": "firefox", 04:21:03 INFO - "script_repo_revision": "production", 04:21:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:21:03 INFO - "repository": "", 04:21:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:21:03 INFO - "buildid": "20161114013321", 04:21:03 INFO - "pgo_build": "True", 04:21:03 INFO - "basedir": "/builds/slave/test", 04:21:03 INFO - "buildnumber": 620, 04:21:03 INFO - "slavename": "talos-linux64-ix-069", 04:21:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:21:03 INFO - "platform": "ubuntu64_hw", 04:21:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:21:03 INFO - "branch": "mozilla-aurora", 04:21:03 INFO - "repo_path": "releases/mozilla-aurora", 04:21:03 INFO - "revision": "3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7", 04:21:03 INFO - "stage_platform": "linux64-pgo", 04:21:03 INFO - "builduid": "4a12ef8c63a34fc8b847622d02cb6a4f", 04:21:03 INFO - "slavebuilddir": "test" 04:21:03 INFO - } 04:21:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 04:21:03 INFO - Running post-action listener: _resource_record_post_action 04:21:03 INFO - [mozharness: 2016-11-14 12:21:03.545472Z] Finished read-buildbot-config step (success) 04:21:03 INFO - [mozharness: 2016-11-14 12:21:03.545562Z] Running download-and-extract step. 04:21:03 INFO - Running pre-action listener: _resource_record_pre_action 04:21:03 INFO - Running main action method: download_and_extract 04:21:03 INFO - mkdir: /builds/slave/test/build/tests 04:21:03 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')]} 04:21:03 INFO - trying https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:21:03 INFO - Downloading https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/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 04:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/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 04:21:04 INFO - Downloaded 1361 bytes. 04:21:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:21:04 INFO - Using the following test package requirements: 04:21:04 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:04 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:04 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:21:04 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'jsshell-linux-x86_64.zip'], 04:21:04 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:04 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:04 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:21:04 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:21:04 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:04 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:04 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:21:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:04 INFO - Fetch https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:21:04 INFO - Expected file size: 21961157 04:21:09 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 04:21:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:21:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:21:09 INFO - Expected file size: 21961157 04:21:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 04:21:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:21:14 INFO - Fetch https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:21:14 INFO - Expected file size: 14414089 04:21:15 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')]} 04:21:15 INFO - trying https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:21:15 INFO - Downloading https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/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 04:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/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 04:21:17 INFO - Downloaded 64058857 bytes. 04:21:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:21:17 INFO - mkdir: /builds/slave/test/properties 04:21:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:17 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:17 INFO - Contents: 04:21:17 INFO - build_url:https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:21:17 INFO - Running post-action listener: _resource_record_post_action 04:21:17 INFO - Running post-action listener: set_extra_try_arguments 04:21:17 INFO - [mozharness: 2016-11-14 12:21:17.771545Z] Finished download-and-extract step (success) 04:21:17 INFO - [mozharness: 2016-11-14 12:21:17.771772Z] Running populate-webroot step. 04:21:17 INFO - Running pre-action listener: _resource_record_pre_action 04:21:17 INFO - Running main action method: populate_webroot 04:21:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:17 INFO - '--tppagecycles', 04:21:17 INFO - '7'], 04:21:17 INFO - 'tests': ['tsvgm']}}, 04:21:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['damp', 'tps']}, 04:21:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'tests': ['damp', 'tps']}, 04:21:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['dromaeo_dom']}, 04:21:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['basic_compositor_video']}, 04:21:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:21:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['a11yr', 04:21:17 INFO - 'ts_paint', 04:21:17 INFO - 'tpaint', 04:21:17 INFO - 'sessionrestore', 04:21:17 INFO - 'sessionrestore_no_auto_restore', 04:21:17 INFO - 'tabpaint']}, 04:21:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['tsvgx', 04:21:17 INFO - 'tsvgr_opacity', 04:21:17 INFO - 'tart', 04:21:17 INFO - 'tscrollx', 04:21:17 INFO - 'cart']}, 04:21:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:17 INFO - 'tsvgr_opacity', 04:21:17 INFO - 'tart', 04:21:17 INFO - 'tscrollx', 04:21:17 INFO - 'cart']}, 04:21:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'talos_options': ['--disable-e10s'], 04:21:17 INFO - 'tests': ['tp5o']}, 04:21:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'tests': ['tp5o']}, 04:21:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'talos_options': ['--disable-e10s', 04:21:17 INFO - '--xperf_path', 04:21:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:17 INFO - 'tests': ['tp5n']}, 04:21:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:17 INFO - 'talos_options': ['--xperf_path', 04:21:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:17 INFO - 'tests': ['tp5n']}}, 04:21:17 INFO - 'talos.zip': {'path': '', 04:21:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:17 INFO - Running post-action listener: _resource_record_post_action 04:21:17 INFO - [mozharness: 2016-11-14 12:21:17.789166Z] Finished populate-webroot step (success) 04:21:17 INFO - [mozharness: 2016-11-14 12:21:17.789254Z] Running create-virtualenv step. 04:21:17 INFO - Running pre-action listener: _resource_record_pre_action 04:21:17 INFO - Running main action method: create_virtualenv 04:21:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:17 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 04:21:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:17 INFO - Using real prefix '/usr' 04:21:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:18 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:20 INFO - Installing pip.................done. 04:21:20 INFO - Return code: 0 04:21:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:20 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 04:21:20 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 04:21:20 INFO - Using env: {'DISPLAY': ':0', 04:21:20 INFO - 'HOME': '/home/cltbld', 04:21:20 INFO - 'LANG': 'en_US.UTF-8', 04:21:20 INFO - 'LANGUAGE': 'en_US:en', 04:21:20 INFO - 'LOGNAME': 'cltbld', 04:21:20 INFO - 'MAIL': '/var/mail/cltbld', 04:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:20 INFO - 'MOZ_NO_REMOTE': '1', 04:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:20 INFO - 'NO_EM_RESTART': '1', 04:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:20 INFO - 'PWD': '/builds/slave/test', 04:21:20 INFO - 'SHELL': '/bin/bash', 04:21:20 INFO - 'SHLVL': '1', 04:21:20 INFO - 'TERM': 'linux', 04:21:20 INFO - 'TMOUT': '86400', 04:21:20 INFO - 'USER': 'cltbld', 04:21:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:20 INFO - '_': '/tools/buildbot/bin/python'} 04:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:20 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 04:21:20 INFO - Cleaning up... 04:21:20 INFO - Return code: 0 04:21:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:20 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 04:21:20 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 04:21:20 INFO - Using env: {'DISPLAY': ':0', 04:21:20 INFO - 'HOME': '/home/cltbld', 04:21:20 INFO - 'LANG': 'en_US.UTF-8', 04:21:20 INFO - 'LANGUAGE': 'en_US:en', 04:21:20 INFO - 'LOGNAME': 'cltbld', 04:21:20 INFO - 'MAIL': '/var/mail/cltbld', 04:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:20 INFO - 'MOZ_NO_REMOTE': '1', 04:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:20 INFO - 'NO_EM_RESTART': '1', 04:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:20 INFO - 'PWD': '/builds/slave/test', 04:21:20 INFO - 'SHELL': '/bin/bash', 04:21:20 INFO - 'SHLVL': '1', 04:21:20 INFO - 'TERM': 'linux', 04:21:20 INFO - 'TMOUT': '86400', 04:21:20 INFO - 'USER': 'cltbld', 04:21:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:20 INFO - '_': '/tools/buildbot/bin/python'} 04:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:20 INFO - Downloading/unpacking psutil>=3.1.1 04:21:20 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 04:21:20 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 04:21:20 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 04:21:20 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 04:21:20 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 04:21:20 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 04:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:22 INFO - Installing collected packages: psutil 04:21:22 INFO - Running setup.py install for psutil 04:21:22 INFO - building 'psutil._psutil_linux' extension 04:21:22 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 04:21:23 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 04:21:23 INFO - building 'psutil._psutil_posix' extension 04:21:23 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 04:21:23 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 04:21:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:23 INFO - Successfully installed psutil 04:21:23 INFO - Cleaning up... 04:21:23 INFO - Return code: 0 04:21:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:21:23 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')]} 04:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:23 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')]} 04:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:23 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:23 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 04:21:23 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 04:21:23 INFO - Using env: {'DISPLAY': ':0', 04:21:23 INFO - 'HOME': '/home/cltbld', 04:21:23 INFO - 'LANG': 'en_US.UTF-8', 04:21:23 INFO - 'LANGUAGE': 'en_US:en', 04:21:23 INFO - 'LOGNAME': 'cltbld', 04:21:23 INFO - 'MAIL': '/var/mail/cltbld', 04:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:23 INFO - 'MOZ_NO_REMOTE': '1', 04:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:23 INFO - 'NO_EM_RESTART': '1', 04:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:23 INFO - 'PWD': '/builds/slave/test', 04:21:23 INFO - 'SHELL': '/bin/bash', 04:21:23 INFO - 'SHLVL': '1', 04:21:23 INFO - 'TERM': 'linux', 04:21:23 INFO - 'TMOUT': '86400', 04:21:23 INFO - 'USER': 'cltbld', 04:21:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:23 INFO - '_': '/tools/buildbot/bin/python'} 04:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:21:25 INFO - Installing collected packages: mozsystemmonitor 04:21:25 INFO - Running setup.py install for mozsystemmonitor 04:21:25 INFO - Successfully installed mozsystemmonitor 04:21:25 INFO - Cleaning up... 04:21:25 INFO - Return code: 0 04:21:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:25 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 04:21:25 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 04:21:25 INFO - Using env: {'DISPLAY': ':0', 04:21:25 INFO - 'HOME': '/home/cltbld', 04:21:25 INFO - 'LANG': 'en_US.UTF-8', 04:21:25 INFO - 'LANGUAGE': 'en_US:en', 04:21:25 INFO - 'LOGNAME': 'cltbld', 04:21:25 INFO - 'MAIL': '/var/mail/cltbld', 04:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:25 INFO - 'MOZ_NO_REMOTE': '1', 04:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:25 INFO - 'NO_EM_RESTART': '1', 04:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:25 INFO - 'PWD': '/builds/slave/test', 04:21:25 INFO - 'SHELL': '/bin/bash', 04:21:25 INFO - 'SHLVL': '1', 04:21:25 INFO - 'TERM': 'linux', 04:21:25 INFO - 'TMOUT': '86400', 04:21:25 INFO - 'USER': 'cltbld', 04:21:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:25 INFO - '_': '/tools/buildbot/bin/python'} 04:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:21:25 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 04:21:25 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 04:21:25 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 04:21:25 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 04:21:25 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 04:21:25 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 04:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:21:27 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 04:21:27 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 04:21:27 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 04:21:27 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 04:21:27 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 04:21:27 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 04:21:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:28 INFO - warning: no files found matching '*.txt' 04:21:28 INFO - no previously-included directories found matching 'build' 04:21:28 INFO - no previously-included directories found matching 'dist' 04:21:28 INFO - no previously-included directories found matching '.git*' 04:21:28 INFO - Installing collected packages: jsonschema, functools32 04:21:28 INFO - Running setup.py install for functools32 04:21:28 INFO - warning: no files found matching '*.txt' 04:21:28 INFO - no previously-included directories found matching 'build' 04:21:28 INFO - no previously-included directories found matching 'dist' 04:21:28 INFO - no previously-included directories found matching '.git*' 04:21:28 INFO - Successfully installed jsonschema functools32 04:21:28 INFO - Cleaning up... 04:21:28 INFO - Return code: 0 04:21:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:21:28 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')]} 04:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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')]} 04:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:28 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 04:21:28 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 04:21:28 INFO - Using env: {'DISPLAY': ':0', 04:21:28 INFO - 'HOME': '/home/cltbld', 04:21:28 INFO - 'LANG': 'en_US.UTF-8', 04:21:28 INFO - 'LANGUAGE': 'en_US:en', 04:21:28 INFO - 'LOGNAME': 'cltbld', 04:21:28 INFO - 'MAIL': '/var/mail/cltbld', 04:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:28 INFO - 'MOZ_NO_REMOTE': '1', 04:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:28 INFO - 'NO_EM_RESTART': '1', 04:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:28 INFO - 'PWD': '/builds/slave/test', 04:21:28 INFO - 'SHELL': '/bin/bash', 04:21:28 INFO - 'SHLVL': '1', 04:21:28 INFO - 'TERM': 'linux', 04:21:28 INFO - 'TMOUT': '86400', 04:21:28 INFO - 'USER': 'cltbld', 04:21:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:28 INFO - '_': '/tools/buildbot/bin/python'} 04:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:21:28 INFO - Cleaning up... 04:21:28 INFO - Return code: 0 04:21:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:28 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')]} 04:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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')]} 04:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:28 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:28 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 04:21:28 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 04:21:28 INFO - Using env: {'DISPLAY': ':0', 04:21:28 INFO - 'HOME': '/home/cltbld', 04:21:28 INFO - 'LANG': 'en_US.UTF-8', 04:21:28 INFO - 'LANGUAGE': 'en_US:en', 04:21:28 INFO - 'LOGNAME': 'cltbld', 04:21:28 INFO - 'MAIL': '/var/mail/cltbld', 04:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:28 INFO - 'MOZ_NO_REMOTE': '1', 04:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:28 INFO - 'NO_EM_RESTART': '1', 04:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:28 INFO - 'PWD': '/builds/slave/test', 04:21:28 INFO - 'SHELL': '/bin/bash', 04:21:28 INFO - 'SHLVL': '1', 04:21:28 INFO - 'TERM': 'linux', 04:21:28 INFO - 'TMOUT': '86400', 04:21:28 INFO - 'USER': 'cltbld', 04:21:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:28 INFO - '_': '/tools/buildbot/bin/python'} 04:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:28 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 04:21:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:30 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 04:21:30 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 04:21:30 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 04:21:30 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 04:21:30 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 04:21:30 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 04:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:31 INFO - Downloading docopt-0.6.1.tar.gz 04:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:31 INFO - Running setup.py install for blobuploader 04:21:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:31 INFO - Running setup.py install for requests 04:21:31 INFO - Running setup.py install for docopt 04:21:32 INFO - Successfully installed blobuploader requests docopt 04:21:32 INFO - Cleaning up... 04:21:32 INFO - Return code: 0 04:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:32 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 04:21:32 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 04:21:32 INFO - Using env: {'DISPLAY': ':0', 04:21:32 INFO - 'HOME': '/home/cltbld', 04:21:32 INFO - 'LANG': 'en_US.UTF-8', 04:21:32 INFO - 'LANGUAGE': 'en_US:en', 04:21:32 INFO - 'LOGNAME': 'cltbld', 04:21:32 INFO - 'MAIL': '/var/mail/cltbld', 04:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:32 INFO - 'MOZ_NO_REMOTE': '1', 04:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:32 INFO - 'NO_EM_RESTART': '1', 04:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:32 INFO - 'PWD': '/builds/slave/test', 04:21:32 INFO - 'SHELL': '/bin/bash', 04:21:32 INFO - 'SHLVL': '1', 04:21:32 INFO - 'TERM': 'linux', 04:21:32 INFO - 'TMOUT': '86400', 04:21:32 INFO - 'USER': 'cltbld', 04:21:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:32 INFO - '_': '/tools/buildbot/bin/python'} 04:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:32 INFO - Running setup.py (path:/tmp/pip-ndFOQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:32 INFO - Running setup.py (path:/tmp/pip-UeOZOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:32 INFO - Running setup.py (path:/tmp/pip-v6Cl2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:32 INFO - Running setup.py (path:/tmp/pip-f0ThsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:32 INFO - Running setup.py (path:/tmp/pip-BQqXw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:32 INFO - Running setup.py (path:/tmp/pip-ITHNHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:32 INFO - Running setup.py (path:/tmp/pip-6_DEhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:32 INFO - Running setup.py (path:/tmp/pip-n7UYJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:32 INFO - Running setup.py (path:/tmp/pip-75HpiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:32 INFO - Running setup.py (path:/tmp/pip-znShrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:33 INFO - Running setup.py (path:/tmp/pip-EP7Bzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:33 INFO - Running setup.py (path:/tmp/pip-fBY0W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:33 INFO - Running setup.py (path:/tmp/pip-WQ3eH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:33 INFO - Running setup.py (path:/tmp/pip-HMsEx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:33 INFO - Running setup.py (path:/tmp/pip-pQYuA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:33 INFO - Running setup.py (path:/tmp/pip-BuZFqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:33 INFO - Running setup.py (path:/tmp/pip-o1BnPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:33 INFO - Running setup.py install for manifestparser 04:21:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozcrash 04:21:33 INFO - Running setup.py install for mozdebug 04:21:33 INFO - Running setup.py install for mozdevice 04:21:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozfile 04:21:34 INFO - Running setup.py install for mozhttpd 04:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozinfo 04:21:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozInstall 04:21:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozleak 04:21:34 INFO - Running setup.py install for mozlog 04:21:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for moznetwork 04:21:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozprocess 04:21:34 INFO - Running setup.py install for mozprofile 04:21:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozrunner 04:21:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:35 INFO - Running setup.py install for mozscreenshot 04:21:35 INFO - Running setup.py install for moztest 04:21:35 INFO - Running setup.py install for mozversion 04:21:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:35 INFO - Cleaning up... 04:21:35 INFO - Return code: 0 04:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:35 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')]} 04:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:35 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')]} 04:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:35 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:35 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 04:21:35 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 04:21:35 INFO - Using env: {'DISPLAY': ':0', 04:21:35 INFO - 'HOME': '/home/cltbld', 04:21:35 INFO - 'LANG': 'en_US.UTF-8', 04:21:35 INFO - 'LANGUAGE': 'en_US:en', 04:21:35 INFO - 'LOGNAME': 'cltbld', 04:21:35 INFO - 'MAIL': '/var/mail/cltbld', 04:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:35 INFO - 'MOZ_NO_REMOTE': '1', 04:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:35 INFO - 'NO_EM_RESTART': '1', 04:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:35 INFO - 'PWD': '/builds/slave/test', 04:21:35 INFO - 'SHELL': '/bin/bash', 04:21:35 INFO - 'SHLVL': '1', 04:21:35 INFO - 'TERM': 'linux', 04:21:35 INFO - 'TMOUT': '86400', 04:21:35 INFO - 'USER': 'cltbld', 04:21:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:35 INFO - '_': '/tools/buildbot/bin/python'} 04:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:35 INFO - Running setup.py (path:/tmp/pip-NzW7lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:35 INFO - Running setup.py (path:/tmp/pip-t7S4QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:35 INFO - Running setup.py (path:/tmp/pip-CtXH6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:35 INFO - Running setup.py (path:/tmp/pip-EVZc9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:35 INFO - Running setup.py (path:/tmp/pip-tqKndB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:35 INFO - Running setup.py (path:/tmp/pip-wGz3Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:35 INFO - Running setup.py (path:/tmp/pip-VbKvWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:36 INFO - Running setup.py (path:/tmp/pip-OWNZxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:36 INFO - Running setup.py (path:/tmp/pip-tt2JVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:36 INFO - Running setup.py (path:/tmp/pip-3648mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:36 INFO - Running setup.py (path:/tmp/pip-sAwkGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:36 INFO - Running setup.py (path:/tmp/pip-nnzbFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:36 INFO - Running setup.py (path:/tmp/pip-nXTuy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:36 INFO - Running setup.py (path:/tmp/pip-IyL1_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:36 INFO - Running setup.py (path:/tmp/pip-2n9YIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:36 INFO - Running setup.py (path:/tmp/pip-vmuYtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:36 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)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:36 INFO - Running setup.py (path:/tmp/pip-5n7Amz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:36 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)) 04:21:36 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)) 04:21:36 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)) 04:21:36 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)) 04:21:36 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)) 04:21:36 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)) 04:21:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:38 INFO - Downloading blessings-1.6.tar.gz 04:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:38 INFO - Installing collected packages: blessings 04:21:38 INFO - Running setup.py install for blessings 04:21:38 INFO - Successfully installed blessings 04:21:38 INFO - Cleaning up... 04:21:38 INFO - Return code: 0 04:21:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:39 INFO - Reading from file tmpfile_stdout 04:21:39 INFO - Current package versions: 04:21:39 INFO - argparse == 1.2.1 04:21:39 INFO - blessings == 1.6 04:21:39 INFO - blobuploader == 1.2.4 04:21:39 INFO - docopt == 0.6.1 04:21:39 INFO - functools32 == 3.2.3-2 04:21:39 INFO - jsonschema == 2.5.1 04:21:39 INFO - manifestparser == 1.1 04:21:39 INFO - mozInstall == 1.12 04:21:39 INFO - mozcrash == 0.17 04:21:39 INFO - mozdebug == 0.1 04:21:39 INFO - mozdevice == 0.48 04:21:39 INFO - mozfile == 1.2 04:21:39 INFO - mozhttpd == 0.7 04:21:39 INFO - mozinfo == 0.9 04:21:39 INFO - mozleak == 0.1 04:21:39 INFO - mozlog == 3.4 04:21:39 INFO - moznetwork == 0.27 04:21:39 INFO - mozprocess == 0.23 04:21:39 INFO - mozprofile == 0.28 04:21:39 INFO - mozrunner == 6.12 04:21:39 INFO - mozscreenshot == 0.1 04:21:39 INFO - mozsystemmonitor == 0.3 04:21:39 INFO - moztest == 0.7 04:21:39 INFO - mozversion == 1.4 04:21:39 INFO - psutil == 3.1.1 04:21:39 INFO - requests == 1.2.3 04:21:39 INFO - wsgiref == 0.1.2 04:21:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 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 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:39 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 04:21:39 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 04:21:39 INFO - Using env: {'DISPLAY': ':0', 04:21:39 INFO - 'HOME': '/home/cltbld', 04:21:39 INFO - 'LANG': 'en_US.UTF-8', 04:21:39 INFO - 'LANGUAGE': 'en_US:en', 04:21:39 INFO - 'LOGNAME': 'cltbld', 04:21:39 INFO - 'MAIL': '/var/mail/cltbld', 04:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:39 INFO - 'MOZ_NO_REMOTE': '1', 04:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:39 INFO - 'NO_EM_RESTART': '1', 04:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:39 INFO - 'PWD': '/builds/slave/test', 04:21:39 INFO - 'SHELL': '/bin/bash', 04:21:39 INFO - 'SHLVL': '1', 04:21:39 INFO - 'TERM': 'linux', 04:21:39 INFO - 'TMOUT': '86400', 04:21:39 INFO - 'USER': 'cltbld', 04:21:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:39 INFO - '_': '/tools/buildbot/bin/python'} 04:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 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)) 04:21:39 INFO - Cleaning up... 04:21:39 INFO - Return code: 0 04:21:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d0ad49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', '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 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:21:39 INFO - Using env: {'DISPLAY': ':0', 04:21:39 INFO - 'HOME': '/home/cltbld', 04:21:39 INFO - 'LANG': 'en_US.UTF-8', 04:21:39 INFO - 'LANGUAGE': 'en_US:en', 04:21:39 INFO - 'LOGNAME': 'cltbld', 04:21:39 INFO - 'MAIL': '/var/mail/cltbld', 04:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:39 INFO - 'MOZ_NO_REMOTE': '1', 04:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:39 INFO - 'NO_EM_RESTART': '1', 04:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:39 INFO - 'PWD': '/builds/slave/test', 04:21:39 INFO - 'SHELL': '/bin/bash', 04:21:39 INFO - 'SHLVL': '1', 04:21:39 INFO - 'TERM': 'linux', 04:21:39 INFO - 'TMOUT': '86400', 04:21:39 INFO - 'USER': 'cltbld', 04:21:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:39 INFO - '_': '/tools/buildbot/bin/python'} 04:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:39 INFO - Cleaning up... 04:21:39 INFO - Return code: 0 04:21:39 INFO - Running post-action listener: _resource_record_post_action 04:21:39 INFO - Running post-action listener: _start_resource_monitoring 04:21:39 INFO - Starting resource monitoring. 04:21:39 INFO - [mozharness: 2016-11-14 12:21:39.646295Z] Finished create-virtualenv step (success) 04:21:39 INFO - [mozharness: 2016-11-14 12:21:39.646797Z] Running install step. 04:21:39 INFO - Running pre-action listener: _resource_record_pre_action 04:21:39 INFO - Running main action method: install 04:21:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:39 INFO - Reading from file tmpfile_stdout 04:21:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:39 INFO - Reading from file tmpfile_stdout 04:21:39 INFO - Output received: 04:21:39 INFO - Usage: mozinstall [options] installer 04:21:39 INFO - Options: 04:21:39 INFO - -h, --help show this help message and exit 04:21:39 INFO - -d DEST, --destination=DEST 04:21:39 INFO - Directory to install application into. [default: 04:21:39 INFO - "/builds/slave/test"] 04:21:39 INFO - --app=APP Application being installed. [default: firefox] 04:21:39 INFO - mkdir: /builds/slave/test/build/application 04:21:39 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'] 04:21:39 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 04:21:55 INFO - Reading from file tmpfile_stdout 04:21:55 INFO - Output received: 04:21:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:55 INFO - Running post-action listener: _resource_record_post_action 04:21:55 INFO - [mozharness: 2016-11-14 12:21:55.904787Z] Finished install step (success) 04:21:55 INFO - [mozharness: 2016-11-14 12:21:55.905030Z] Running run-tests step. 04:21:55 INFO - Running pre-action listener: _resource_record_pre_action 04:21:55 INFO - Running main action method: run_tests 04:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:55 INFO - Python 2.7.3 04:21:55 INFO - Return code: 0 04:21:55 INFO - grabbing minidump binary from tooltool 04:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:55 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 0xd53f60>, '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 0xd54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd551d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:55 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 04:21:55 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 04:21:55 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 04:21:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:55 INFO - Return code: 0 04:21:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:55 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/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:21:55 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/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:21:55 INFO - Using env: {'DISPLAY': ':0', 04:21:55 INFO - 'HOME': '/home/cltbld', 04:21:55 INFO - 'LANG': 'en_US.UTF-8', 04:21:55 INFO - 'LANGUAGE': 'en_US:en', 04:21:55 INFO - 'LOGNAME': 'cltbld', 04:21:55 INFO - 'MAIL': '/var/mail/cltbld', 04:21:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:55 INFO - 'MOZ_NO_REMOTE': '1', 04:21:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:55 INFO - 'NO_EM_RESTART': '1', 04:21:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:55 INFO - 'PWD': '/builds/slave/test', 04:21:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:55 INFO - 'SHELL': '/bin/bash', 04:21:55 INFO - 'SHLVL': '1', 04:21:55 INFO - 'TERM': 'linux', 04:21:55 INFO - 'TMOUT': '86400', 04:21:55 INFO - 'USER': 'cltbld', 04:21:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465', 04:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:55 INFO - '_': '/tools/buildbot/bin/python'} 04:21:55 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/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:21:56 INFO - mozversion application_buildid: 20161114013321 04:21:56 INFO - mozversion application_changeset: 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 04:21:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:21:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:56 INFO - mozversion application_name: Firefox 04:21:56 INFO - mozversion application_remotingname: firefox-dev 04:21:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:21:56 INFO - mozversion application_vendor: Mozilla 04:21:56 INFO - mozversion application_version: 51.0a2 04:21:56 INFO - mozversion platform_buildid: 20161114013321 04:21:56 INFO - mozversion platform_changeset: 3b68ca65557a1eb724b3f9b3e0d1fe2a1a7574d7 04:21:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:21:56 INFO - mozversion platform_version: 51.0a2 04:21:56 INFO - using testdate: 1479126116 04:21:56 INFO - actual date: 1479126116 04:21:56 INFO - starting webserver on 'localhost:58445' 04:21:56 INFO - SUITE-START | Running 2 tests 04:21:56 INFO - TEST-START | dromaeo_css 04:21:56 INFO - operating with platform_type : linux_ 04:21:56 INFO - Initialising browser for dromaeo_css test... 04:21:56 INFO - TEST-INFO | started process 6132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlkCtu/profile http://localhost:58445/getInfo.html) 04:22:00 INFO - PROCESS | 6132 | __metrics Screen width/height:1600/1200 04:22:00 INFO - PROCESS | 6132 | colorDepth:24 04:22:00 INFO - PROCESS | 6132 | Browser inner width/height: 1024/697 04:22:00 INFO - PROCESS | 6132 | __metrics 04:22:00 INFO - PROCESS | 6132 | 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" 04:22:00 INFO - PROCESS | 6132 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:01 INFO - PROCESS | 6132 | console.error: PushService: 04:22:01 INFO - PROCESS | 6132 | stateChangeProcessEnqueue: Error transitioning state 04:22:01 INFO - PROCESS | 6132 | UnknownError 04:22:01 INFO - TEST-INFO | 6132: exit 0 04:22:01 INFO - Browser initialized. 04:22:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:01 INFO - TEST-INFO | started process 6222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlkCtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:13 INFO - PROCESS | 6222 | RSS: Main: 144842752 04:22:13 INFO - PROCESS | 6222 | 04:23:04 INFO - PROCESS | 6222 | 1479126184937 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] 04:25:14 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58445/tests/dromaeo/cssquery-ext.html) 04:25:15 INFO - PROCESS | 6222 | RSS: Main: 265568256 04:25:15 INFO - PROCESS | 6222 | 04:28:17 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-ext.html (next: http://localhost:58445/tests/dromaeo/cssquery-jquery.html) 04:28:18 INFO - PROCESS | 6222 | RSS: Main: 233050112 04:28:18 INFO - PROCESS | 6222 | 04:31:20 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58445/tests/dromaeo/cssquery-mootools.html) 04:31:20 INFO - PROCESS | 6222 | RSS: Main: 174915584 04:31:20 INFO - PROCESS | 6222 | 04:34:22 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58445/tests/dromaeo/cssquery-prototype.html) 04:34:23 INFO - PROCESS | 6222 | RSS: Main: 176377856 04:34:23 INFO - PROCESS | 6222 | 04:37:25 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58445/tests/dromaeo/cssquery-yui.html) 04:37:26 INFO - PROCESS | 6222 | RSS: Main: 178212864 04:37:26 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | Cycle 1(1): loaded http://localhost:58445/tests/dromaeo/cssquery-yui.html (next: http://localhost:58445/tests/dromaeo/cssquery-dojo.html) 04:40:29 INFO - PROCESS | 6222 | RSS: Main: 260657152 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | __start_tp_report 04:40:29 INFO - PROCESS | 6222 | _x_x_mozilla_page_load 04:40:29 INFO - PROCESS | 6222 | _x_x_mozilla_page_load_details 04:40:29 INFO - PROCESS | 6222 | |i|pagename|runs| 04:40:29 INFO - PROCESS | 6222 | |0;dojo.html;3163.478026125689;3199.60004999375;3211.6788321167887;3233.094733474625;3249.57755491786;5589.74846131924;5693.715314234288;5707.6290041147295;5716.799912003081;5737.598368114233;5637.295338082739;5665.348484924235;5679.744411501482;5705.372409035002;5740.253767010283;5106.565941894934;5122.769475373599;5145.125328694112;5154.226865970097;5165.896682066356;5034.697918124906;5209.661372010807;5211.088059589576;5226;5228.895422091556;5009.448960614348;5096.694198348093;5101.132807422747;5113.360829896263;5153.994970980661;5154.07226699194;5165.070287348276;5246.737663116829;5251.921221181686;5279.577633789288;4959.454460009396;5090.338256026693;5176.715280659562;5211.452797456251;5230.320058392423;5504.80733174337;5533.08704063829;5571.303587051619;5596.608237423382;5627.521660658849;6021.09683547467;6035.939640603582;6150.569460137792;6156.445919867234;6156.7537298508005;5982.072778719262;6201.503879689614;6209.348018458042;6221.377862213788;6223.657698826562;5571.052921003439;5621.29733783273;5621.831345059655;5636.718164091779;5644.096944488862;6183.072539119168;6184.907226391608;6187.226596675416;6189.659568723673;6191.164192834;5674.829755107354;5968.46283834457;5977.372375900555;5979.252593425822;5983.611065280743;5783.334916484574;5852.94147058524;5905.379935106752;5912.556558258148;5915.231019967463;5874.265716785402;5877.47102760745;5878.735456904449;5879.588428810028;5935.317438494542;5951.672658003851;5998.1002849572915;6037.456628903332;6057.939420605738;6063.969680151571;4636.095961287584;4647.140279048387;4650.209464391061;4652.930206046912;4667.97304592989;4062.0657248832936;4135.875923722293;4140.44104045956;4142.834286628501;4151.066010147692;5572.275604171432;5611.410801865827;5636;5687.829365119053;5783.248177736868;6105.145279660851;6157.876842463125;6160.630362178284;6166.907496387557;6172.783952561639;5745.339285982165;5750.971245143831;5762.135679648086;5776.1624564437925;5779.682117483495;5114.820981265638;5169.147090730063;5214.817481388209;5230.476952304739;5299.947000529945;6234.719437625317;6238.906416403757;6251.468625166821;6260.186175797208;6310.211223597051;6160.7535698571555;6171.074338849029;6177.289611694712;6182.103594978793;6186.690665466798;6085.269767627913;6139.631622102688;6250.49996000328;6331.145295385249;6336.3030066693545;6054.27348718139;6093.542984276109;6108.8778224436155;6123.142760013513;6142.662153581596;6178.227721534809;6198.783042593487;6214.533909956681;6219.968900155471;6222.0355844844125;6024.638521688713;6025.698715064317;6043.153958445909;6050.9394906050375;6051.92783587449;5812.099124635688;5847.7368518417625;5864.472197502245;5881.470667639933;5904.468597826216;5882.088276317178;5895.380984996514;5924.733386997509;5928.199693041557;5940.108983652487;6010.128531363015;6031.125486804476;6031.366706495754;6033.75864965414;6033.78881739137;5654.15187721845;5680.77276908919;5787.56593255516;5810.564207684356;5817.0983497557945 04:40:29 INFO - PROCESS | 6222 | |1;ext.html;589.1163255117324;636.5003472274266;650.6063831382014;658.9802305930824;675.0987431778582;36479.99999999996;47316.76341618291;48716;48724.51275487244;48752.75623621877;50311.74844125774;50330;50431.24353134697;50480.49519504804;50823.23765143516;8616.310695144373;9523.761905952355;9728.075832795874;9733.707988760312;9734.367266127714;8486.27866631334;11235.943820280887;11498.19512634116;11511.366874821922;11913.821292680617;11680;11694.181407301492;11697.70755731105;11705.531778728884;11757.941210293937;11344.546218151265;11379.601713940056;11423.200375973685;11424.42877856104;11441.942790286079;11181.32912025281;11253.156013299036;11269.66191014271;11284.266522676;11285;46754.76622616899;47247.52752472465;47319.76340118312;47337.76331118357;47347;3809.142942837867;3868.4197370394386;3945.447637330776;4166.33338665812;4617.468991066037;35652;35815.641843581754;35965.46051809225;36056.27887442263;37847.432288515694;4156.501219853637;4173.10278290166;4207.431996680471;4231.238377092122;4313.029568347097;380443;386135;386872;387837.9999999972;388365;60993.780124397264;61096.38903610907;61104.38895611076;61191;61228;41769.58230417657;42666.360004599956;42929;45029.09941801146;45037.32444013342;20111.39665810028;20361.287354942506;20368.490787730425;20375.694364584542;20376;14335;14732.926335368255;15458.845411545966;15608.219589020504;15744.60638484047;20386.69419958702;21062;21236.78763212348;21353;21386.86131386849;7352.551970717602;7397.667104980289;7415.369693575999;7464.813379665552;7858.836448947989;1025.5128813813378;1092.595739576362;1119.5745616665615;1148.833419154218;1155.2086820527966;32708.836455817567;33101.834490827394;33137;33309;33768.83115584456;1154.6189757380043;1205.596125298035;1238.3065483329365;1249.1693024139026;1316.2826259688493;17954.640907182045;18081.36715214961;18135.274589016557;18193;18237.81762182361;609507;610186;612173;613011;617717;64710;65103.67448162729;65351;65391.34608653947;65495.34504654892;1346.596021193638;1370.0615078671142;1412.8304603447857;1437.4968760933798;1453.8764205042478;31861.36277274488;33718.66281337155;33742.831285843415;34130.48804267888;34808;56559.43440565706;62484.37515624968;63841;63851.36148638454;70081.64959175172;546664.3333916684;551535;551771;552913;553213;31721.8413907929;32103;32201.194970125933;33867.66132338645;48428;52490.475095248556;52503.737481312346;52682;52968.470315296356;53850;44578.55421445744;45263.54736452725;45356;45716.77141614404;46469.76765116288;44462.333065003404;45508.31737523874;45744.313835293164;45807.54192458033;46503.302450462594;41613.37579936243;41949.37075943924;42626.360604590336;42742.78628606837;42777.57222427861;37836.81081594574;39450.21099577935;39964.40053399143;40025.59974400219;40109.79945100256;28117;28302.716972830833;28370.43259134847;28450.57324140181;28544.57183142296 04:40:29 INFO - PROCESS | 6222 | |2;jquery.html;390.52265772913574;434.9217140914636;436.5699785711075;437.1846506265814;447.3960153792383;16951.49145525633;19609.901950490246;21857.234996775078;21922;22227.44431389214;19510.804891951077;20019.799802001977;20150.798492015074;20157;20629.07169177387;5550.417206193342;5559.499645031946;5772.971135144318;5777.046787280094;5777.768889244425;5588.273524441817;5708.08670612702;5713.457221563945;5715.342735585398;5722.027255366577;5595.49640532352;5715.3141623005085;5716.542676585863;5716.599838011341;6009.369016253274;6119.6328220306705;6148;6149.3235744068115;6162.5378096642935;6184;5458;5532.612717109804;5545.445455454463;5586.469285417878;5599.496045355938;15314.617134571614;15445.150516721576;15469.690606187813;22628.54742905149;24860.875695621588;2401.483681008574;2441.377448750575;2448.4980578981267;2650.2579277802247;2907.5057240269207;10918.836217456745;11131.944340278247;11189.272697274651;11621.825672614917;11631.6510504685;1971.2607772085469;2026.847986401011;2061.4846288427893;2081.8126368626745;2084.937451876446;90563;91170;92947.53526232393;93735.53132234364;94942.52528737312;10439.843402348972;12118.939405303094;12204.694882627828;12266.325352105541;12270.631881043582;15693.921530392276;15764.290606922716;16820.327186912386;16835.32658693663;17469.126543672766;9045.457272563668;9072.909270907207;9080.500572468578;9178.21985131258;9425.104615061558;9074;9095.681651142178;9119.68081117171;9265.768355791159;9364.391314564531;5139.717315547681;5245;5259.184826351921;5265.4997775211295;5323.1749078892835;2096.1720120552295;2101.2540548105508;2113.830893528514;2151.118041602935;2182.2253100149537;1004.1213937804421;1011.0950699124243;1016.6594190946116;1058.5130839813771;1066.3388699006666;18575.349862754738;18807;20644.17423303051;20847.8957605211;21178.576428471653;1019.454591793387;1052.2423854824515;1068.433730123036;1070.309650275568;1124.9325040497433;11129.833052504218;11524.193306468635;11616.012638925786;11698.649040528799;11711.1802173847;524135;528614;529313;537871;540301;97566.5121674387;107181;107522;107750;109403;1050.6427814543092;1062.2882668612049;1083.7940791249796;1102.2339474065448;1108.451316598289;17770.5557361067;17886.731699024265;18154.546136346697;18161.18274677616;18502.352417665315;43881.56118438775;44270;44618.77690611656;45654.31518527291;46662;63362.683186585615;63902.3609763915;63914.36085639084;64134;64522.67738661277;9058.41120327203;9101.40840845343;9260;9455.101765332283;9556.61773529051;12081.57714479989;12297;12316.261024338568;13078.215307081226;13549.796753048515;10076.798464030824;10660;10682.519286631965;10974.231803773659;11068.833967490333;11644.126690498077;11777.882221177679;11835.822462662894;12292.877071229532;12504.187227830162;10858.945705271422;11052.723681908017;11070.501827417624;11161.497732602214;11292.548298068314;9113.954430227806;9332.953335233551;9470.195033422237;9530.475823829756;9571.856422153813;5953.047512397996;8624.008239052338;9782.141393135282;10578.312409693346;10591.576336946437 04:40:29 INFO - PROCESS | 6222 | |3;mootools.html;1392.6031081141878;1525.3136088760054;1548.6515534004848;1723.155653729672;1859.5258209156664;8771.47371157731;9395.624175033;9705.805883882318;9731.659391921276;10103.646372376968;9875.407475551454;9960.501974901263;9964.501774911261;9973.601055957772;9976.750581235472;2592.338953566838;2619.5415802234534;2621.0957219759152;2622.3313055170906;2623.2654856640074;2560.9103681371157;2615.163147792707;2635.6046593011106;2639.656844610198;2640.1815437214523;2522.4702812409414;2543.313305407539;2584.147231413629;2587.5730504466833;2591.8444893306464;2358.492924021335;2367.2661474942824;2375.916842910507;2408.385861605297;2417.226487523993;2474.8638824864624;2482.888270027853;2492.6385674077155;2494.077191439161;2512.5979843224995;9525.714228573153;9615.086566776145;9855.90144098564;9856;9876.851847222297;5576.191452239403;5795.507381872546;5809.390014048507;5823.068309070529;5831.795887143972;3631.2918980798754;3661.6704496595435;3702.629737026276;3718.033311339071;3722.8883133506038;1248.8813562711528;1262.6780171056414;1275.6236910111538;1278.6355888571804;1325.357201757147;13764.587062388144;13882;13888.513902013483;13889.4444222231;13904.513342033082;4913.656044076952;4974.129527332702;5168.689878607295;5188.688678679291;5236.423993360727;10862.511186996604;10864.94567527173;10874.72813179661;10879.12966962641;10892.292001019909;5962.55280853929;5965.910511342333;5982.4316689914385;5989;5993.520518358521;4820.927686084711;4887.095887260868;5406.216098665672;5461.208124821878;5564.527015203672;4110.424540564323;4185.769782661922;4217.725847819882;4277.329456920519;4295.935560966588;1294.8122522234223;1324.668832791802;1329.7074643578396;1336.3251557963167;1342.8657134286493;835.9164083591592;916.3997581584073;946.2288235088381;959.9184069354044;975.0980343182528;6151.477124444383;6170.5372097092895;6275.058741188858;6305.779297724557;6397.040443933447;1005.6932635546228;1042.4110377636612;1043.1967385113571;1077.978440431187;1089.0634054712941;4099.733517321364;4170.895727606834;4177.958220417818;4197.412362269285;4205.6635469163;12194.57318993831;12468.43892024861;12529.93735031319;12532.937335313265;12536.74926501483;12392.876071239172;12445.75108497825;12455.813162802566;12481.251124932533;12531.498740050478;8922.598483068148;9129.406588571721;9200.493972831424;9270.212031977357;9272.953635231781;6047.03247480401;6216.067589861557;6218.720157593009;6224.105790807296;6228.937710622836;11425.714357140805;11436.485358158736;11526.250793698719;11532.135089868125;11550.249233799776;11296.83054754163;11372.37451940118;11482.94258528702;11583.942080289544;11712.414379281172;7469.7385591504035;7723.382129429745;7892.0924093729955;8174;8311.625976831177;9327;9695.22438204956;9696.6121355145;9705.466199359103;9710.465924373944;8285.50286982759;8301.83396332082;8374.874376884474;8410.957945210235;8495.787605309917;8085.231902969209;8136.349092072502;8194.877076843972;8202.917970820215;8355.080941096354;7349.412047036118;7421.2207718190975;7439.739609113872;7444.664990075351;7495.812604684927;5368.087425137658;5371.543418809445;5494.587905906993;5524.25477503392;5604.327480702179;5476.288082549402;5553.944460555343;5581.302337207849;5637.520810731134;5675.687837168995 04:40:29 INFO - PROCESS | 6222 | |4;prototype.html;357.36389227175624;367.2856294507184;369.9426588878723;374.2197518174606;376.76075691935614;5517.475839795218;5554.638948468347;5570.415106413829;5581.6371935824145;5588.189712491686;5272.288241087452;5494.203340515623;5497.340319161696;5497.728851333461;5505.4584716279505;4294.141171765652;4360.6293465055505;4363.345498175283;4365.541618130098;4386.912261754763;4370.759608221547;4375.496817865955;4391.770304314781;4391.978040109795;4408.316710909814;4333.306670932651;4334.219840428722;4341.674374421915;4352.303631418974;4359.782010899458;4249.150169966004;4304.849330273457;4316.6546676265825;4323.567643235683;4341.9782901085455;3828.7511311764647;3836.9232615347814;3840.788756618385;3843.347360634954;3844.442555829417;5334.306540149794;5354.6881014151395;5358.598105142091;5383.165609330521;5399.595030372738;4804.807807687688;4951.291804327501;4953.712034870923;4998.775055122528;5005.499450054966;5732.856678583027;5739.426057394227;5739.626924249952;5749.655020698771;5792.102224155263;4280.293751530994;4293.3989241506215;4298.527162012176;4307.267764480046;4314.094040251551;5637;5806.935145398238;5811.767529298823;5909.3204281507315;5920.644761314292;4221.219074471172;4268.762059002916;4276.332230430135;4387.144506821203;4391.494978077498;4442.133783912106;4455.019895622958;4455.462865311462;4455.4876189238;4459.44256967879;4868.930704450594;4990.700557966534;4995.600351971833;4998.825276060123;5008.899822003539;5724.599278050497;5767.509761670305;5768.932747441737;5771.826845194651;5778.670905691714;1512.8865335099692;1532.8926975111635;1533.2640332640394;1536.3931247157311;1537.8308386077747;941.9324582541393;998.9150922171551;1003.2743680868894;1014.5890914179769;1019.3323373190572;4861.7326047067045;4869.488703686133;4898.779554919965;4939.3084968104495;4940.851774446773;5192.61055420845;5193.792248310026;5220.451852555503;5239.240310155006;5251.059406732165;4477.888052798706;4860.708357498562;4886.804527818918;4891.364122664102;4910.607151427877;2744.7099863064727;2766.9446611067665;2767.529519981608;2771.237909574883;2772.849267553983;5255.5795536357;5278.308062887955;5304.92042619361;5314.581865251302;5353.678779273256;5093.745312734422;5301.257823904656;5308.575313974873;5338.359396872323;5360.274609146683;5309.203619457112;5343.332083489564;5364.7317634118135;5365.678059316453;5375.855124751985;5223.268742375994;5229.581633469237;5239.240310155083;5255.816046438356;5273.578113750814;4868.707877527359;5172.663776854492;5176.844694659167;5181.55956743666;5208.5312321891215;5390.460953904735;5837.620554663933;5971.701414929149;5972.790952316648;6012.6392416455155;4288.249556327568;4354.433923589913;4388.4295041645655;4402.779861006873;4405.867823965286;5651.660900345993;5815.3893841147765;5842.685395785914;5855.443732845373;5861.560382971379;5653.11691037582;5684.687342196054;5701.116326969326;5701.486866182064;5714.657120572779;5652.689102099424;5657.2928383952;5684.175794509855;5704.458076482728;5705.315362156568;5392.379876314274;5597.496225339739;5618.494335509824;5636.4927156556105;5664.348599911063;5710.543156547383;5717.256236847801;5718.513926316144;5733.541316694571;5746.770129194785;5590.748416321194;5590.9440905592055;5595;5597.6641401516035;5600.879824035128 04:40:29 INFO - PROCESS | 6222 | |5;yui.html;784.4508843809335;789.4118881433333;811.4847072109211;837.8826964225005;891.777055736066;16976.490705278848;17115.74326385105;17264.395746148886;17416.91291543542;17428.12859357032;16423.83576164238;16485.91757041213;16521.173941302917;16560.75158872618;16565.91717041413;710.1761956130889;742.4468770765787;840.231188462556;874.899386570543;890.5057692980394;877.714742708619;891.2869704236617;892.5938697892443;893.3166127912152;894.3784070071302;934.9205317548017;935.672514619881;936.372630337672;936.489613160829;936.8828896387952;737.0860133434556;761.4099073218244;905.7916679163764;925.9768505787375;933.5192375926404;675.3651567526509;681.0295329155982;681.158768920383;681.4616453002172;681.9147606549182;17787.644247114986;17999.64000719978;18025.27898884043;18028.36900708469;18045.819541804543;17265.223064962105;17377.652446951117;17401.65196696059;17715.202815873316;18246.087695615166;13528.864711352859;13570.864291357157;13634.181949082988;13911.165330080126;13935.233562154077;4070.7354021988476;4101.405296232029;4124.257633625946;4183.832646694129;4274.166537525184;95040.52479737558;96342.036579634;97947;98109;99570.50214748952;12518.937405312916;12546.874531254753;12755.42600582976;13192.934035329761;13659.590212293648;24945.875270623532;25010.249692509253;25089.49821003606;25106.623400649005;25266.242012739647;9299.256059515223;9341.159295663423;9375.437473751597;9540.284478663989;9578;5123.769430375642;5130.1535246684625;5166.54929049856;5202.4277329493725;5282.313299271147;3869.5550011748446;4021.2560676274984;4025.0742329264435;4029.5366032906004;4035;584.7339460545442;598.8862116197909;602.4036204157852;606.4360145065043;607.2682417686677;739.2053542441896;755.1919446192521;757.325979877909;761.1475147834461;787.4212453846418;9890.901090989142;10315.690529284133;10344.32761870476;10578.57685692579;10977.451127443595;635.8156134720879;697.2121502702016;707.1302298173173;742.361569050616;780.2158830375437;5103.974480127576;5209.505097015777;5251.343582052244;5263.473652634706;5331.573474122061;73712.26287737161;75820.24179758242;130626;131260.3436982809;133189;116622;117391.41304293423;117525.4123729393;118710.40644796721;120410;57381.71309143511;59075;61493.69253153705;93479.5326023352;100681;10234.232432567736;10966.506507207036;11042;11044.723881902695;11223.88776112261;54358.45641543534;54395.18407223815;55227.44772552223;55247.723761380934;56819.14771278352;70426.64786676034;72064.63967680128;76458;81518;82117.58941205256;13879.930600346934;14136.858631413554;14367.28163591837;14464.27678616086;14766.114033157615;16130.919345403197;16268.773761899336;16561.337546498005;17048.744268836224;17713.734293985344;13644.795328069888;13752.518661846787;14528.346224419714;14612.561623151323;14838.258087095817;14815;15108.924455378092;15118.168500732565;15232.238388080774;15465.690686186439;14787.852121478647;15297.235138243266;15679.451219207273;15708.450204242796;15977;11725.92699552376;11821.75871533511;11998.76002479963;12293.508259669514;12527;13188.868111318763;13313.800292995418;13350.132241404666;13407.86592134066;13420.194788312732 04:40:29 INFO - PROCESS | 6222 | __end_tp_report 04:40:29 INFO - PROCESS | 6222 | __start_cc_report 04:40:29 INFO - PROCESS | 6222 | _x_x_mozilla_cycle_collect,1051 04:40:29 INFO - PROCESS | 6222 | __end_cc_report 04:40:29 INFO - PROCESS | 6222 | __startTimestamp1479127229477__endTimestamp 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | ------- Summary: start ------- 04:40:29 INFO - PROCESS | 6222 | Number of tests: 6 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#0] dojo.html Cycles:165 Average:5631.10 Median:5817.10 stddev:654.59 (11.3%) stddev-sans-first:627.32 04:40:29 INFO - PROCESS | 6222 | Values: 3163.5 3199.6 3211.7 3233.1 3249.6 5589.7 5693.7 5707.6 5716.8 5737.6 5637.3 5665.3 5679.7 5705.4 5740.3 5106.6 5122.8 5145.1 5154.2 5165.9 5034.7 5209.7 5211.1 5226.0 5228.9 5009.4 5096.7 5101.1 5113.4 5154.0 5154.1 5165.1 5246.7 5251.9 5279.6 4959.5 5090.3 5176.7 5211.5 5230.3 5504.8 5533.1 5571.3 5596.6 5627.5 6021.1 6035.9 6150.6 6156.4 6156.8 5982.1 6201.5 6209.3 6221.4 6223.7 5571.1 5621.3 5621.8 5636.7 5644.1 6183.1 6184.9 6187.2 6189.7 6191.2 5674.8 5968.5 5977.4 5979.3 5983.6 5783.3 5852.9 5905.4 5912.6 5915.2 5874.3 5877.5 5878.7 5879.6 5935.3 5951.7 5998.1 6037.5 6057.9 6064.0 4636.1 4647.1 4650.2 4652.9 4668.0 4062.1 4135.9 4140.4 4142.8 4151.1 5572.3 5611.4 5636.0 5687.8 5783.2 6105.1 6157.9 6160.6 6166.9 6172.8 5745.3 5751.0 5762.1 5776.2 5779.7 5114.8 5169.1 5214.8 5230.5 5299.9 6234.7 6238.9 6251.5 6260.2 6310.2 6160.8 6171.1 6177.3 6182.1 6186.7 6085.3 6139.6 6250.5 6331.1 6336.3 6054.3 6093.5 6108.9 6123.1 6142.7 6178.2 6198.8 6214.5 6220.0 6222.0 6024.6 6025.7 6043.2 6050.9 6051.9 5812.1 5847.7 5864.5 5881.5 5904.5 5882.1 5895.4 5924.7 5928.2 5940.1 6010.1 6031.1 6031.4 6033.8 6033.8 5654.2 5680.8 5787.6 5810.6 5817.1 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#1] ext.html Cycles:180 Average:68586.56 Median:40067.70 stddev:139587.75 (348.4%) stddev-sans-first:139885.96 04:40:29 INFO - PROCESS | 6222 | Values: 589.1 636.5 650.6 659.0 675.1 36480.0 47316.8 48716.0 48724.5 48752.8 50311.7 50330.0 50431.2 50480.5 50823.2 8616.3 9523.8 9728.1 9733.7 9734.4 8486.3 11235.9 11498.2 11511.4 11913.8 11680.0 11694.2 11697.7 11705.5 11757.9 11344.5 11379.6 11423.2 11424.4 11441.9 11181.3 11253.2 11269.7 11284.3 11285.0 46754.8 47247.5 47319.8 47337.8 47347.0 3809.1 3868.4 3945.4 4166.3 4617.5 35652.0 35815.6 35965.5 36056.3 37847.4 4156.5 4173.1 4207.4 4231.2 4313.0 380443.0 386135.0 386872.0 387838.0 388365.0 60993.8 61096.4 61104.4 61191.0 61228.0 41769.6 42666.4 42929.0 45029.1 45037.3 20111.4 20361.3 20368.5 20375.7 20376.0 14335.0 14732.9 15458.8 15608.2 15744.6 20386.7 21062.0 21236.8 21353.0 21386.9 7352.6 7397.7 7415.4 7464.8 7858.8 1025.5 1092.6 1119.6 1148.8 1155.2 32708.8 33101.8 33137.0 33309.0 33768.8 1154.6 1205.6 1238.3 1249.2 1316.3 17954.6 18081.4 18135.3 18193.0 18237.8 609507.0 610186.0 612173.0 613011.0 617717.0 64710.0 65103.7 65351.0 65391.3 65495.3 1346.6 1370.1 1412.8 1437.5 1453.9 31861.4 33718.7 33742.8 34130.5 34808.0 56559.4 62484.4 63841.0 63851.4 70081.6 546664.3 551535.0 551771.0 552913.0 553213.0 31721.8 32103.0 32201.2 33867.7 48428.0 52490.5 52503.7 52682.0 52968.5 53850.0 44578.6 45263.5 45356.0 45716.8 46469.8 44462.3 45508.3 45744.3 45807.5 46503.3 41613.4 41949.4 42626.4 42742.8 42777.6 37836.8 39450.2 39964.4 40025.6 40109.8 28117.0 28302.7 28370.4 28450.6 28544.6 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#2] jquery.html Cycles:180 Average:31257.66 Median:12019.73 stddev:88067.81 (732.7%) stddev-sans-first:88284.37 04:40:29 INFO - PROCESS | 6222 | Values: 390.5 434.9 436.6 437.2 447.4 16951.5 19609.9 21857.2 21922.0 22227.4 19510.8 20019.8 20150.8 20157.0 20629.1 5550.4 5559.5 5773.0 5777.0 5777.8 5588.3 5708.1 5713.5 5715.3 5722.0 5595.5 5715.3 5716.5 5716.6 6009.4 6119.6 6148.0 6149.3 6162.5 6184.0 5458.0 5532.6 5545.4 5586.5 5599.5 15314.6 15445.2 15469.7 22628.5 24860.9 2401.5 2441.4 2448.5 2650.3 2907.5 10918.8 11131.9 11189.3 11621.8 11631.7 1971.3 2026.8 2061.5 2081.8 2084.9 90563.0 91170.0 92947.5 93735.5 94942.5 10439.8 12118.9 12204.7 12266.3 12270.6 15693.9 15764.3 16820.3 16835.3 17469.1 9045.5 9072.9 9080.5 9178.2 9425.1 9074.0 9095.7 9119.7 9265.8 9364.4 5139.7 5245.0 5259.2 5265.5 5323.2 2096.2 2101.3 2113.8 2151.1 2182.2 1004.1 1011.1 1016.7 1058.5 1066.3 18575.3 18807.0 20644.2 20847.9 21178.6 1019.5 1052.2 1068.4 1070.3 1124.9 11129.8 11524.2 11616.0 11698.6 11711.2 524135.0 528614.0 529313.0 537871.0 540301.0 97566.5 107181.0 107522.0 107750.0 109403.0 1050.6 1062.3 1083.8 1102.2 1108.5 17770.6 17886.7 18154.5 18161.2 18502.4 43881.6 44270.0 44618.8 45654.3 46662.0 63362.7 63902.4 63914.4 64134.0 64522.7 9058.4 9101.4 9260.0 9455.1 9556.6 12081.6 12297.0 12316.3 13078.2 13549.8 10076.8 10660.0 10682.5 10974.2 11068.8 11644.1 11777.9 11835.8 12292.9 12504.2 10858.9 11052.7 11070.5 11161.5 11292.5 9114.0 9333.0 9470.2 9530.5 9571.9 5953.0 8624.0 9782.1 10578.3 10591.6 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#3] mootools.html Cycles:180 Average:6363.72 Median:4558.43 stddev:3715.64 (81.5%) stddev-sans-first:3707.28 04:40:29 INFO - PROCESS | 6222 | Values: 1392.6 1525.3 1548.7 1723.2 1859.5 8771.5 9395.6 9705.8 9731.7 10103.6 9875.4 9960.5 9964.5 9973.6 9976.8 2592.3 2619.5 2621.1 2622.3 2623.3 2560.9 2615.2 2635.6 2639.7 2640.2 2522.5 2543.3 2584.1 2587.6 2591.8 2358.5 2367.3 2375.9 2408.4 2417.2 2474.9 2482.9 2492.6 2494.1 2512.6 9525.7 9615.1 9855.9 9856.0 9876.9 5576.2 5795.5 5809.4 5823.1 5831.8 3631.3 3661.7 3702.6 3718.0 3722.9 1248.9 1262.7 1275.6 1278.6 1325.4 13764.6 13882.0 13888.5 13889.4 13904.5 4913.7 4974.1 5168.7 5188.7 5236.4 10862.5 10864.9 10874.7 10879.1 10892.3 5962.6 5965.9 5982.4 5989.0 5993.5 4820.9 4887.1 5406.2 5461.2 5564.5 4110.4 4185.8 4217.7 4277.3 4295.9 1294.8 1324.7 1329.7 1336.3 1342.9 835.9 916.4 946.2 959.9 975.1 6151.5 6170.5 6275.1 6305.8 6397.0 1005.7 1042.4 1043.2 1078.0 1089.1 4099.7 4170.9 4178.0 4197.4 4205.7 12194.6 12468.4 12529.9 12532.9 12536.7 12392.9 12445.8 12455.8 12481.3 12531.5 8922.6 9129.4 9200.5 9270.2 9273.0 6047.0 6216.1 6218.7 6224.1 6228.9 11425.7 11436.5 11526.3 11532.1 11550.2 11296.8 11372.4 11482.9 11583.9 11712.4 7469.7 7723.4 7892.1 8174.0 8311.6 9327.0 9695.2 9696.6 9705.5 9710.5 8285.5 8301.8 8374.9 8411.0 8495.8 8085.2 8136.3 8194.9 8202.9 8355.1 7349.4 7421.2 7439.7 7444.7 7495.8 5368.1 5371.5 5494.6 5524.3 5604.3 5476.3 5553.9 5581.3 5637.5 5675.7 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#4] prototype.html Cycles:180 Average:4696.99 Median:5214.49 stddev:1321.66 (25.3%) stddev-sans-first:1284.61 04:40:29 INFO - PROCESS | 6222 | Values: 357.4 367.3 369.9 374.2 376.8 5517.5 5554.6 5570.4 5581.6 5588.2 5272.3 5494.2 5497.3 5497.7 5505.5 4294.1 4360.6 4363.3 4365.5 4386.9 4370.8 4375.5 4391.8 4392.0 4408.3 4333.3 4334.2 4341.7 4352.3 4359.8 4249.2 4304.8 4316.7 4323.6 4342.0 3828.8 3836.9 3840.8 3843.3 3844.4 5334.3 5354.7 5358.6 5383.2 5399.6 4804.8 4951.3 4953.7 4998.8 5005.5 5732.9 5739.4 5739.6 5749.7 5792.1 4280.3 4293.4 4298.5 4307.3 4314.1 5637.0 5806.9 5811.8 5909.3 5920.6 4221.2 4268.8 4276.3 4387.1 4391.5 4442.1 4455.0 4455.5 4455.5 4459.4 4868.9 4990.7 4995.6 4998.8 5008.9 5724.6 5767.5 5768.9 5771.8 5778.7 1512.9 1532.9 1533.3 1536.4 1537.8 941.9 998.9 1003.3 1014.6 1019.3 4861.7 4869.5 4898.8 4939.3 4940.9 5192.6 5193.8 5220.5 5239.2 5251.1 4477.9 4860.7 4886.8 4891.4 4910.6 2744.7 2766.9 2767.5 2771.2 2772.8 5255.6 5278.3 5304.9 5314.6 5353.7 5093.7 5301.3 5308.6 5338.4 5360.3 5309.2 5343.3 5364.7 5365.7 5375.9 5223.3 5229.6 5239.2 5255.8 5273.6 4868.7 5172.7 5176.8 5181.6 5208.5 5390.5 5837.6 5971.7 5972.8 6012.6 4288.2 4354.4 4388.4 4402.8 4405.9 5651.7 5815.4 5842.7 5855.4 5861.6 5653.1 5684.7 5701.1 5701.5 5714.7 5652.7 5657.3 5684.2 5704.5 5705.3 5392.4 5597.5 5618.5 5636.5 5664.3 5710.5 5717.3 5718.5 5733.5 5746.8 5590.7 5590.9 5595.0 5597.7 5600.9 04:40:29 INFO - PROCESS | 6222 | 04:40:29 INFO - PROCESS | 6222 | [#5] yui.html Cycles:180 Average:22484.33 Median:4027.31 stddev:32054.71 (795.9%) stddev-sans-first:32103.22 04:40:29 INFO - PROCESS | 6222 | Values: 784.5 789.4 811.5 837.9 891.8 16976.5 17115.7 17264.4 17416.9 17428.1 16423.8 16485.9 16521.2 16560.8 16565.9 710.2 742.4 840.2 874.9 890.5 877.7 891.3 892.6 893.3 894.4 934.9 935.7 936.4 936.5 936.9 737.1 761.4 905.8 926.0 933.5 675.4 681.0 681.2 681.5 681.9 17787.6 17999.6 18025.3 18028.4 18045.8 17265.2 17377.7 17401.7 17715.2 18246.1 13528.9 13570.9 13634.2 13911.2 13935.2 4070.7 4101.4 4124.3 4183.8 4274.2 95040.5 96342.0 97947.0 98109.0 99570.5 12518.9 12546.9 12755.4 13192.9 13659.6 24945.9 25010.2 25089.5 25106.6 25266.2 9299.3 9341.2 9375.4 9540.3 9578.0 5123.8 5130.2 5166.5 5202.4 5282.3 3869.6 4021.3 4025.1 4029.5 4035.0 584.7 598.9 602.4 606.4 607.3 739.2 755.2 757.3 761.1 787.4 9890.9 10315.7 10344.3 10578.6 10977.5 635.8 697.2 707.1 742.4 780.2 5104.0 5209.5 5251.3 5263.5 5331.6 73712.3 75820.2 130626.0 131260.3 133189.0 116622.0 117391.4 117525.4 118710.4 120410.0 57381.7 59075.0 61493.7 93479.5 100681.0 10234.2 10966.5 11042.0 11044.7 11223.9 54358.5 54395.2 55227.4 55247.7 56819.1 70426.6 72064.6 76458.0 81518.0 82117.6 13879.9 14136.9 14367.3 14464.3 14766.1 16130.9 16268.8 16561.3 17048.7 17713.7 13644.8 13752.5 14528.3 14612.6 14838.3 14815.0 15108.9 15118.2 15232.2 15465.7 14787.9 15297.2 15679.5 15708.5 15977.0 11725.9 11821.8 11998.8 12293.5 12527.0 13188.9 13313.8 13350.1 13407.9 13420.2 04:40:29 INFO - PROCESS | 6222 | -------- Summary: end -------- 04:40:29 INFO - PROCESS | 6222 | 04:40:30 INFO - TEST-INFO | 6222: exit 0 04:40:30 INFO - TEST-OK | dromaeo_css | took 1114030ms 04:40:30 INFO - TEST-START | kraken 04:40:30 INFO - operating with platform_type : linux_ 04:40:30 INFO - Initialising browser for kraken test... 04:40:30 INFO - TEST-INFO | started process 6541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvwy1C/profile http://localhost:58445/getInfo.html) 04:40:34 INFO - PROCESS | 6541 | __metrics Screen width/height:1600/1200 04:40:34 INFO - PROCESS | 6541 | colorDepth:24 04:40:34 INFO - PROCESS | 6541 | Browser inner width/height: 1024/697 04:40:34 INFO - PROCESS | 6541 | __metrics 04:40:34 INFO - PROCESS | 6541 | 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" 04:40:34 INFO - PROCESS | 6541 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:35 INFO - PROCESS | 6541 | console.error: PushService: 04:40:35 INFO - PROCESS | 6541 | stateChangeProcessEnqueue: Error transitioning state 04:40:35 INFO - PROCESS | 6541 | UnknownError 04:40:35 INFO - TEST-INFO | 6541: exit 0 04:40:35 INFO - Browser initialized. 04:40:35 INFO - Running cycle 1/1 for kraken test... 04:40:35 INFO - TEST-INFO | started process 6630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvwy1C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:47 INFO - PROCESS | 6630 | RSS: Main: 144408576 04:40:47 INFO - PROCESS | 6630 | 04:40:50 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58445/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:51 INFO - PROCESS | 6630 | RSS: Main: 186327040 04:40:51 INFO - PROCESS | 6630 | 04:40:53 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58445/tests/kraken/driver.html?testName=audio-dft) 04:40:54 INFO - PROCESS | 6630 | RSS: Main: 175480832 04:40:54 INFO - PROCESS | 6630 | 04:40:57 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58445/tests/kraken/driver.html?testName=audio-fft) 04:40:57 INFO - PROCESS | 6630 | RSS: Main: 266862592 04:40:57 INFO - PROCESS | 6630 | 04:40:59 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58445/tests/kraken/driver.html?testName=audio-oscillator) 04:41:00 INFO - PROCESS | 6630 | RSS: Main: 173330432 04:41:00 INFO - PROCESS | 6630 | 04:41:02 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58445/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:02 INFO - PROCESS | 6630 | RSS: Main: 175525888 04:41:02 INFO - PROCESS | 6630 | 04:41:05 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58445/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:06 INFO - PROCESS | 6630 | RSS: Main: 210931712 04:41:06 INFO - PROCESS | 6630 | 04:41:09 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58445/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:10 INFO - PROCESS | 6630 | RSS: Main: 209592320 04:41:10 INFO - PROCESS | 6630 | 04:41:13 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58445/tests/kraken/driver.html?testName=json-parse-financial) 04:41:13 INFO - PROCESS | 6630 | RSS: Main: 209932288 04:41:13 INFO - PROCESS | 6630 | 04:41:15 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58445/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:15 INFO - PROCESS | 6630 | RSS: Main: 171814912 04:41:15 INFO - PROCESS | 6630 | 04:41:17 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:18 INFO - PROCESS | 6630 | RSS: Main: 179580928 04:41:18 INFO - PROCESS | 6630 | 04:41:20 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:20 INFO - PROCESS | 6630 | RSS: Main: 188911616 04:41:20 INFO - PROCESS | 6630 | 04:41:23 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:23 INFO - PROCESS | 6630 | RSS: Main: 197111808 04:41:23 INFO - PROCESS | 6630 | 04:41:26 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:27 INFO - PROCESS | 6630 | RSS: Main: 193261568 04:41:27 INFO - PROCESS | 6630 | 04:41:28 INFO - PROCESS | 6630 | Cycle 1(1): loaded http://localhost:58445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58445/tests/kraken/driver.html?testName=ai-astar) 04:41:29 INFO - PROCESS | 6630 | RSS: Main: 243757056 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | __start_tp_report 04:41:29 INFO - PROCESS | 6630 | _x_x_mozilla_page_load 04:41:29 INFO - PROCESS | 6630 | _x_x_mozilla_page_load_details 04:41:29 INFO - PROCESS | 6630 | |i|pagename|runs| 04:41:29 INFO - PROCESS | 6630 | |0;ai-astar;110;109;109;109;110;110;109;110;108;108 04:41:29 INFO - PROCESS | 6630 | |1;audio-beat-detection;144;120;122;153;123;118;117;117;149;119 04:41:29 INFO - PROCESS | 6630 | |2;audio-dft;161;162;161;160;163;162;162;161;161;161 04:41:29 INFO - PROCESS | 6630 | |3;audio-fft;75;76;77;109;76;76;76;76;111;75 04:41:29 INFO - PROCESS | 6630 | |4;audio-oscillator;81;81;111;81;82;81;100;83;81;103 04:41:29 INFO - PROCESS | 6630 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 04:41:29 INFO - PROCESS | 6630 | |6;imaging-darkroom;146;146;146;148;147;146;146;147;146;146 04:41:29 INFO - PROCESS | 6630 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 04:41:29 INFO - PROCESS | 6630 | |8;json-parse-financial;50;49;49;49;49;49;56;49;50;49 04:41:29 INFO - PROCESS | 6630 | |9;json-stringify-tinderbox;59;60;62;60;60;60;61;60;60;61 04:41:29 INFO - PROCESS | 6630 | |10;stanford-crypto-aes;74;73;73;73;72;74;72;82;76;72 04:41:29 INFO - PROCESS | 6630 | |11;stanford-crypto-ccm;126;123;129;121;127;118;127;117;156;125 04:41:29 INFO - PROCESS | 6630 | |12;stanford-crypto-pbkdf2;157;153;159;153;158;155;152;154;163;151 04:41:29 INFO - PROCESS | 6630 | |13;stanford-crypto-sha256-iterative;62;63;63;62;62;62;62;62;62;60 04:41:29 INFO - PROCESS | 6630 | __end_tp_report 04:41:29 INFO - PROCESS | 6630 | __start_cc_report 04:41:29 INFO - PROCESS | 6630 | _x_x_mozilla_cycle_collect,1589 04:41:29 INFO - PROCESS | 6630 | __end_cc_report 04:41:29 INFO - PROCESS | 6630 | __startTimestamp1479127289123__endTimestamp 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | ------- Summary: start ------- 04:41:29 INFO - PROCESS | 6630 | Number of tests: 14 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 04:41:29 INFO - PROCESS | 6630 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 108.0 108.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:122.50 stddev:14.41 (11.8%) stddev-sans-first:14.11 04:41:29 INFO - PROCESS | 6630 | Values: 144.0 120.0 122.0 153.0 123.0 118.0 117.0 117.0 149.0 119.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 04:41:29 INFO - PROCESS | 6630 | Values: 161.0 162.0 161.0 160.0 163.0 162.0 162.0 161.0 161.0 161.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.41 (19.0%) stddev-sans-first:15.01 04:41:29 INFO - PROCESS | 6630 | Values: 75.0 76.0 77.0 109.0 76.0 76.0 76.0 76.0 111.0 75.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:81.00 stddev:11.56 (14.3%) stddev-sans-first:11.95 04:41:29 INFO - PROCESS | 6630 | Values: 81.0 81.0 111.0 81.0 82.0 81.0 100.0 83.0 81.0 103.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:41:29 INFO - PROCESS | 6630 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:41:29 INFO - PROCESS | 6630 | Values: 146.0 146.0 146.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:41:29 INFO - PROCESS | 6630 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:49.00 stddev:2.18 (4.5%) stddev-sans-first:2.32 04:41:29 INFO - PROCESS | 6630 | Values: 50.0 49.0 49.0 49.0 49.0 49.0 56.0 49.0 50.0 49.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 04:41:29 INFO - PROCESS | 6630 | Values: 59.0 60.0 62.0 60.0 60.0 60.0 61.0 60.0 60.0 61.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.50 stddev:3.03 (4.1%) stddev-sans-first:3.22 04:41:29 INFO - PROCESS | 6630 | Values: 74.0 73.0 73.0 73.0 72.0 74.0 72.0 82.0 76.0 72.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:126.50 stddev:10.97 (8.7%) stddev-sans-first:11.63 04:41:29 INFO - PROCESS | 6630 | Values: 126.0 123.0 129.0 121.0 127.0 118.0 127.0 117.0 156.0 125.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:3.72 (2.4%) stddev-sans-first:3.91 04:41:29 INFO - PROCESS | 6630 | Values: 157.0 153.0 159.0 153.0 158.0 155.0 152.0 154.0 163.0 151.0 04:41:29 INFO - PROCESS | 6630 | 04:41:29 INFO - PROCESS | 6630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 04:41:29 INFO - PROCESS | 6630 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 60.0 04:41:29 INFO - PROCESS | 6630 | -------- Summary: end -------- 04:41:29 INFO - PROCESS | 6630 | 04:41:30 INFO - TEST-INFO | 6630: exit 0 04:41:30 INFO - TEST-OK | kraken | took 59935ms 04:41:30 INFO - SUITE-END | took 1173s 04:41:30 INFO - Completed test suite (00:19:34) 04:41:30 INFO - javascript benchmark 04:41:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3163.478026125689, 3199.60004999375, 3211.6788321167887, 3233.094733474625, 3249.57755491786, 5589.74846131924, 5693.715314234288, 5707.6290041147295, 5716.799912003081, 5737.598368114233, 5637.295338082739, 5665.348484924235, 5679.744411501482, 5705.372409035002, 5740.253767010283, 5106.565941894934, 5122.769475373599, 5145.125328694112, 5154.226865970097, 5165.896682066356, 5034.697918124906, 5209.661372010807, 5211.088059589576, 5226.0, 5228.895422091556, 5009.448960614348, 5096.694198348093, 5101.132807422747, 5113.360829896263, 5153.994970980661, 5154.07226699194, 5165.070287348276, 5246.737663116829, 5251.921221181686, 5279.577633789288, 4959.454460009396, 5090.338256026693, 5176.715280659562, 5211.452797456251, 5230.320058392423, 5504.80733174337, 5533.08704063829, 5571.303587051619, 5596.608237423382, 5627.521660658849, 6021.09683547467, 6035.939640603582, 6150.569460137792, 6156.445919867234, 6156.7537298508005, 5982.072778719262, 6201.503879689614, 6209.348018458042, 6221.377862213788, 6223.657698826562, 5571.052921003439, 5621.29733783273, 5621.831345059655, 5636.718164091779, 5644.096944488862, 6183.072539119168, 6184.907226391608, 6187.226596675416, 6189.659568723673, 6191.164192834, 5674.829755107354, 5968.46283834457, 5977.372375900555, 5979.252593425822, 5983.611065280743, 5783.334916484574, 5852.94147058524, 5905.379935106752, 5912.556558258148, 5915.231019967463, 5874.265716785402, 5877.47102760745, 5878.735456904449, 5879.588428810028, 5935.317438494542, 5951.672658003851, 5998.1002849572915, 6037.456628903332, 6057.939420605738, 6063.969680151571, 4636.095961287584, 4647.140279048387, 4650.209464391061, 4652.930206046912, 4667.97304592989, 4062.0657248832936, 4135.875923722293, 4140.44104045956, 4142.834286628501, 4151.066010147692, 5572.275604171432, 5611.410801865827, 5636.0, 5687.829365119053, 5783.248177736868, 6105.145279660851, 6157.876842463125, 6160.630362178284, 6166.907496387557, 6172.783952561639, 5745.339285982165, 5750.971245143831, 5762.135679648086, 5776.1624564437925, 5779.682117483495, 5114.820981265638, 5169.147090730063, 5214.817481388209, 5230.476952304739, 5299.947000529945, 6234.719437625317, 6238.906416403757, 6251.468625166821, 6260.186175797208, 6310.211223597051, 6160.7535698571555, 6171.074338849029, 6177.289611694712, 6182.103594978793, 6186.690665466798, 6085.269767627913, 6139.631622102688, 6250.49996000328, 6331.145295385249, 6336.3030066693545, 6054.27348718139, 6093.542984276109, 6108.8778224436155, 6123.142760013513, 6142.662153581596, 6178.227721534809, 6198.783042593487, 6214.533909956681, 6219.968900155471, 6222.0355844844125, 6024.638521688713, 6025.698715064317, 6043.153958445909, 6050.9394906050375, 6051.92783587449, 5812.099124635688, 5847.7368518417625, 5864.472197502245, 5881.470667639933, 5904.468597826216, 5882.088276317178, 5895.380984996514, 5924.733386997509, 5928.199693041557, 5940.108983652487, 6010.128531363015, 6031.125486804476, 6031.366706495754, 6033.75864965414, 6033.78881739137, 5654.15187721845, 5680.77276908919, 5787.56593255516, 5810.564207684356, 5817.0983497557945], "value": 5585.569678405785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1163255117324, 636.5003472274266, 650.6063831382014, 658.9802305930824, 675.0987431778582, 36479.99999999996, 47316.76341618291, 48716.0, 48724.51275487244, 48752.75623621877, 50311.74844125774, 50330.0, 50431.24353134697, 50480.49519504804, 50823.23765143516, 8616.310695144373, 9523.761905952355, 9728.075832795874, 9733.707988760312, 9734.367266127714, 8486.27866631334, 11235.943820280887, 11498.19512634116, 11511.366874821922, 11913.821292680617, 11680.0, 11694.181407301492, 11697.70755731105, 11705.531778728884, 11757.941210293937, 11344.546218151265, 11379.601713940056, 11423.200375973685, 11424.42877856104, 11441.942790286079, 11181.32912025281, 11253.156013299036, 11269.66191014271, 11284.266522676, 11285.0, 46754.76622616899, 47247.52752472465, 47319.76340118312, 47337.76331118357, 47347.0, 3809.142942837867, 3868.4197370394386, 3945.447637330776, 4166.33338665812, 4617.468991066037, 35652.0, 35815.641843581754, 35965.46051809225, 36056.27887442263, 37847.432288515694, 4156.501219853637, 4173.10278290166, 4207.431996680471, 4231.238377092122, 4313.029568347097, 380443.0, 386135.0, 386872.0, 387837.9999999972, 388365.0, 60993.780124397264, 61096.38903610907, 61104.38895611076, 61191.0, 61228.0, 41769.58230417657, 42666.360004599956, 42929.0, 45029.09941801146, 45037.32444013342, 20111.39665810028, 20361.287354942506, 20368.490787730425, 20375.694364584542, 20376.0, 14335.0, 14732.926335368255, 15458.845411545966, 15608.219589020504, 15744.60638484047, 20386.69419958702, 21062.0, 21236.78763212348, 21353.0, 21386.86131386849, 7352.551970717602, 7397.667104980289, 7415.369693575999, 7464.813379665552, 7858.836448947989, 1025.5128813813378, 1092.595739576362, 1119.5745616665615, 1148.833419154218, 1155.2086820527966, 32708.836455817567, 33101.834490827394, 33137.0, 33309.0, 33768.83115584456, 1154.6189757380043, 1205.596125298035, 1238.3065483329365, 1249.1693024139026, 1316.2826259688493, 17954.640907182045, 18081.36715214961, 18135.274589016557, 18193.0, 18237.81762182361, 609507.0, 610186.0, 612173.0, 613011.0, 617717.0, 64710.0, 65103.67448162729, 65351.0, 65391.34608653947, 65495.34504654892, 1346.596021193638, 1370.0615078671142, 1412.8304603447857, 1437.4968760933798, 1453.8764205042478, 31861.36277274488, 33718.66281337155, 33742.831285843415, 34130.48804267888, 34808.0, 56559.43440565706, 62484.37515624968, 63841.0, 63851.36148638454, 70081.64959175172, 546664.3333916684, 551535.0, 551771.0, 552913.0, 553213.0, 31721.8413907929, 32103.0, 32201.194970125933, 33867.66132338645, 48428.0, 52490.475095248556, 52503.737481312346, 52682.0, 52968.470315296356, 53850.0, 44578.55421445744, 45263.54736452725, 45356.0, 45716.77141614404, 46469.76765116288, 44462.333065003404, 45508.31737523874, 45744.313835293164, 45807.54192458033, 46503.302450462594, 41613.37579936243, 41949.37075943924, 42626.360604590336, 42742.78628606837, 42777.57222427861, 37836.81081594574, 39450.21099577935, 39964.40053399143, 40025.59974400219, 40109.79945100256, 28117.0, 28302.716972830833, 28370.43259134847, 28450.57324140181, 28544.57183142296], "value": 22297.501494239455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.52265772913574, 434.9217140914636, 436.5699785711075, 437.1846506265814, 447.3960153792383, 16951.49145525633, 19609.901950490246, 21857.234996775078, 21922.0, 22227.44431389214, 19510.804891951077, 20019.799802001977, 20150.798492015074, 20157.0, 20629.07169177387, 5550.417206193342, 5559.499645031946, 5772.971135144318, 5777.046787280094, 5777.768889244425, 5588.273524441817, 5708.08670612702, 5713.457221563945, 5715.342735585398, 5722.027255366577, 5595.49640532352, 5715.3141623005085, 5716.542676585863, 5716.599838011341, 6009.369016253274, 6119.6328220306705, 6148.0, 6149.3235744068115, 6162.5378096642935, 6184.0, 5458.0, 5532.612717109804, 5545.445455454463, 5586.469285417878, 5599.496045355938, 15314.617134571614, 15445.150516721576, 15469.690606187813, 22628.54742905149, 24860.875695621588, 2401.483681008574, 2441.377448750575, 2448.4980578981267, 2650.2579277802247, 2907.5057240269207, 10918.836217456745, 11131.944340278247, 11189.272697274651, 11621.825672614917, 11631.6510504685, 1971.2607772085469, 2026.847986401011, 2061.4846288427893, 2081.8126368626745, 2084.937451876446, 90563.0, 91170.0, 92947.53526232393, 93735.53132234364, 94942.52528737312, 10439.843402348972, 12118.939405303094, 12204.694882627828, 12266.325352105541, 12270.631881043582, 15693.921530392276, 15764.290606922716, 16820.327186912386, 16835.32658693663, 17469.126543672766, 9045.457272563668, 9072.909270907207, 9080.500572468578, 9178.21985131258, 9425.104615061558, 9074.0, 9095.681651142178, 9119.68081117171, 9265.768355791159, 9364.391314564531, 5139.717315547681, 5245.0, 5259.184826351921, 5265.4997775211295, 5323.1749078892835, 2096.1720120552295, 2101.2540548105508, 2113.830893528514, 2151.118041602935, 2182.2253100149537, 1004.1213937804421, 1011.0950699124243, 1016.6594190946116, 1058.5130839813771, 1066.3388699006666, 18575.349862754738, 18807.0, 20644.17423303051, 20847.8957605211, 21178.576428471653, 1019.454591793387, 1052.2423854824515, 1068.433730123036, 1070.309650275568, 1124.9325040497433, 11129.833052504218, 11524.193306468635, 11616.012638925786, 11698.649040528799, 11711.1802173847, 524135.0, 528614.0, 529313.0, 537871.0, 540301.0, 97566.5121674387, 107181.0, 107522.0, 107750.0, 109403.0, 1050.6427814543092, 1062.2882668612049, 1083.7940791249796, 1102.2339474065448, 1108.451316598289, 17770.5557361067, 17886.731699024265, 18154.546136346697, 18161.18274677616, 18502.352417665315, 43881.56118438775, 44270.0, 44618.77690611656, 45654.31518527291, 46662.0, 63362.683186585615, 63902.3609763915, 63914.36085639084, 64134.0, 64522.67738661277, 9058.41120327203, 9101.40840845343, 9260.0, 9455.101765332283, 9556.61773529051, 12081.57714479989, 12297.0, 12316.261024338568, 13078.215307081226, 13549.796753048515, 10076.798464030824, 10660.0, 10682.519286631965, 10974.231803773659, 11068.833967490333, 11644.126690498077, 11777.882221177679, 11835.822462662894, 12292.877071229532, 12504.187227830162, 10858.945705271422, 11052.723681908017, 11070.501827417624, 11161.497732602214, 11292.548298068314, 9113.954430227806, 9332.953335233551, 9470.195033422237, 9530.475823829756, 9571.856422153813, 5953.047512397996, 8624.008239052338, 9782.141393135282, 10578.312409693346, 10591.576336946437], "value": 9620.09304204839, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.6031081141878, 1525.3136088760054, 1548.6515534004848, 1723.155653729672, 1859.5258209156664, 8771.47371157731, 9395.624175033, 9705.805883882318, 9731.659391921276, 10103.646372376968, 9875.407475551454, 9960.501974901263, 9964.501774911261, 9973.601055957772, 9976.750581235472, 2592.338953566838, 2619.5415802234534, 2621.0957219759152, 2622.3313055170906, 2623.2654856640074, 2560.9103681371157, 2615.163147792707, 2635.6046593011106, 2639.656844610198, 2640.1815437214523, 2522.4702812409414, 2543.313305407539, 2584.147231413629, 2587.5730504466833, 2591.8444893306464, 2358.492924021335, 2367.2661474942824, 2375.916842910507, 2408.385861605297, 2417.226487523993, 2474.8638824864624, 2482.888270027853, 2492.6385674077155, 2494.077191439161, 2512.5979843224995, 9525.714228573153, 9615.086566776145, 9855.90144098564, 9856.0, 9876.851847222297, 5576.191452239403, 5795.507381872546, 5809.390014048507, 5823.068309070529, 5831.795887143972, 3631.2918980798754, 3661.6704496595435, 3702.629737026276, 3718.033311339071, 3722.8883133506038, 1248.8813562711528, 1262.6780171056414, 1275.6236910111538, 1278.6355888571804, 1325.357201757147, 13764.587062388144, 13882.0, 13888.513902013483, 13889.4444222231, 13904.513342033082, 4913.656044076952, 4974.129527332702, 5168.689878607295, 5188.688678679291, 5236.423993360727, 10862.511186996604, 10864.94567527173, 10874.72813179661, 10879.12966962641, 10892.292001019909, 5962.55280853929, 5965.910511342333, 5982.4316689914385, 5989.0, 5993.520518358521, 4820.927686084711, 4887.095887260868, 5406.216098665672, 5461.208124821878, 5564.527015203672, 4110.424540564323, 4185.769782661922, 4217.725847819882, 4277.329456920519, 4295.935560966588, 1294.8122522234223, 1324.668832791802, 1329.7074643578396, 1336.3251557963167, 1342.8657134286493, 835.9164083591592, 916.3997581584073, 946.2288235088381, 959.9184069354044, 975.0980343182528, 6151.477124444383, 6170.5372097092895, 6275.058741188858, 6305.779297724557, 6397.040443933447, 1005.6932635546228, 1042.4110377636612, 1043.1967385113571, 1077.978440431187, 1089.0634054712941, 4099.733517321364, 4170.895727606834, 4177.958220417818, 4197.412362269285, 4205.6635469163, 12194.57318993831, 12468.43892024861, 12529.93735031319, 12532.937335313265, 12536.74926501483, 12392.876071239172, 12445.75108497825, 12455.813162802566, 12481.251124932533, 12531.498740050478, 8922.598483068148, 9129.406588571721, 9200.493972831424, 9270.212031977357, 9272.953635231781, 6047.03247480401, 6216.067589861557, 6218.720157593009, 6224.105790807296, 6228.937710622836, 11425.714357140805, 11436.485358158736, 11526.250793698719, 11532.135089868125, 11550.249233799776, 11296.83054754163, 11372.37451940118, 11482.94258528702, 11583.942080289544, 11712.414379281172, 7469.7385591504035, 7723.382129429745, 7892.0924093729955, 8174.0, 8311.625976831177, 9327.0, 9695.22438204956, 9696.6121355145, 9705.466199359103, 9710.465924373944, 8285.50286982759, 8301.83396332082, 8374.874376884474, 8410.957945210235, 8495.787605309917, 8085.231902969209, 8136.349092072502, 8194.877076843972, 8202.917970820215, 8355.080941096354, 7349.412047036118, 7421.2207718190975, 7439.739609113872, 7444.664990075351, 7495.812604684927, 5368.087425137658, 5371.543418809445, 5494.587905906993, 5524.25477503392, 5604.327480702179, 5476.288082549402, 5553.944460555343, 5581.302337207849, 5637.520810731134, 5675.687837168995], "value": 5044.195275606153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.36389227175624, 367.2856294507184, 369.9426588878723, 374.2197518174606, 376.76075691935614, 5517.475839795218, 5554.638948468347, 5570.415106413829, 5581.6371935824145, 5588.189712491686, 5272.288241087452, 5494.203340515623, 5497.340319161696, 5497.728851333461, 5505.4584716279505, 4294.141171765652, 4360.6293465055505, 4363.345498175283, 4365.541618130098, 4386.912261754763, 4370.759608221547, 4375.496817865955, 4391.770304314781, 4391.978040109795, 4408.316710909814, 4333.306670932651, 4334.219840428722, 4341.674374421915, 4352.303631418974, 4359.782010899458, 4249.150169966004, 4304.849330273457, 4316.6546676265825, 4323.567643235683, 4341.9782901085455, 3828.7511311764647, 3836.9232615347814, 3840.788756618385, 3843.347360634954, 3844.442555829417, 5334.306540149794, 5354.6881014151395, 5358.598105142091, 5383.165609330521, 5399.595030372738, 4804.807807687688, 4951.291804327501, 4953.712034870923, 4998.775055122528, 5005.499450054966, 5732.856678583027, 5739.426057394227, 5739.626924249952, 5749.655020698771, 5792.102224155263, 4280.293751530994, 4293.3989241506215, 4298.527162012176, 4307.267764480046, 4314.094040251551, 5637.0, 5806.935145398238, 5811.767529298823, 5909.3204281507315, 5920.644761314292, 4221.219074471172, 4268.762059002916, 4276.332230430135, 4387.144506821203, 4391.494978077498, 4442.133783912106, 4455.019895622958, 4455.462865311462, 4455.4876189238, 4459.44256967879, 4868.930704450594, 4990.700557966534, 4995.600351971833, 4998.825276060123, 5008.899822003539, 5724.599278050497, 5767.509761670305, 5768.932747441737, 5771.826845194651, 5778.670905691714, 1512.8865335099692, 1532.8926975111635, 1533.2640332640394, 1536.3931247157311, 1537.8308386077747, 941.9324582541393, 998.9150922171551, 1003.2743680868894, 1014.5890914179769, 1019.3323373190572, 4861.7326047067045, 4869.488703686133, 4898.779554919965, 4939.3084968104495, 4940.851774446773, 5192.61055420845, 5193.792248310026, 5220.451852555503, 5239.240310155006, 5251.059406732165, 4477.888052798706, 4860.708357498562, 4886.804527818918, 4891.364122664102, 4910.607151427877, 2744.7099863064727, 2766.9446611067665, 2767.529519981608, 2771.237909574883, 2772.849267553983, 5255.5795536357, 5278.308062887955, 5304.92042619361, 5314.581865251302, 5353.678779273256, 5093.745312734422, 5301.257823904656, 5308.575313974873, 5338.359396872323, 5360.274609146683, 5309.203619457112, 5343.332083489564, 5364.7317634118135, 5365.678059316453, 5375.855124751985, 5223.268742375994, 5229.581633469237, 5239.240310155083, 5255.816046438356, 5273.578113750814, 4868.707877527359, 5172.663776854492, 5176.844694659167, 5181.55956743666, 5208.5312321891215, 5390.460953904735, 5837.620554663933, 5971.701414929149, 5972.790952316648, 6012.6392416455155, 4288.249556327568, 4354.433923589913, 4388.4295041645655, 4402.779861006873, 4405.867823965286, 5651.660900345993, 5815.3893841147765, 5842.685395785914, 5855.443732845373, 5861.560382971379, 5653.11691037582, 5684.687342196054, 5701.116326969326, 5701.486866182064, 5714.657120572779, 5652.689102099424, 5657.2928383952, 5684.175794509855, 5704.458076482728, 5705.315362156568, 5392.379876314274, 5597.496225339739, 5618.494335509824, 5636.4927156556105, 5664.348599911063, 5710.543156547383, 5717.256236847801, 5718.513926316144, 5733.541316694571, 5746.770129194785, 5590.748416321194, 5590.9440905592055, 5595.0, 5597.6641401516035, 5600.879824035128], "value": 4287.855950118994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4508843809335, 789.4118881433333, 811.4847072109211, 837.8826964225005, 891.777055736066, 16976.490705278848, 17115.74326385105, 17264.395746148886, 17416.91291543542, 17428.12859357032, 16423.83576164238, 16485.91757041213, 16521.173941302917, 16560.75158872618, 16565.91717041413, 710.1761956130889, 742.4468770765787, 840.231188462556, 874.899386570543, 890.5057692980394, 877.714742708619, 891.2869704236617, 892.5938697892443, 893.3166127912152, 894.3784070071302, 934.9205317548017, 935.672514619881, 936.372630337672, 936.489613160829, 936.8828896387952, 737.0860133434556, 761.4099073218244, 905.7916679163764, 925.9768505787375, 933.5192375926404, 675.3651567526509, 681.0295329155982, 681.158768920383, 681.4616453002172, 681.9147606549182, 17787.644247114986, 17999.64000719978, 18025.27898884043, 18028.36900708469, 18045.819541804543, 17265.223064962105, 17377.652446951117, 17401.65196696059, 17715.202815873316, 18246.087695615166, 13528.864711352859, 13570.864291357157, 13634.181949082988, 13911.165330080126, 13935.233562154077, 4070.7354021988476, 4101.405296232029, 4124.257633625946, 4183.832646694129, 4274.166537525184, 95040.52479737558, 96342.036579634, 97947.0, 98109.0, 99570.50214748952, 12518.937405312916, 12546.874531254753, 12755.42600582976, 13192.934035329761, 13659.590212293648, 24945.875270623532, 25010.249692509253, 25089.49821003606, 25106.623400649005, 25266.242012739647, 9299.256059515223, 9341.159295663423, 9375.437473751597, 9540.284478663989, 9578.0, 5123.769430375642, 5130.1535246684625, 5166.54929049856, 5202.4277329493725, 5282.313299271147, 3869.5550011748446, 4021.2560676274984, 4025.0742329264435, 4029.5366032906004, 4035.0, 584.7339460545442, 598.8862116197909, 602.4036204157852, 606.4360145065043, 607.2682417686677, 739.2053542441896, 755.1919446192521, 757.325979877909, 761.1475147834461, 787.4212453846418, 9890.901090989142, 10315.690529284133, 10344.32761870476, 10578.57685692579, 10977.451127443595, 635.8156134720879, 697.2121502702016, 707.1302298173173, 742.361569050616, 780.2158830375437, 5103.974480127576, 5209.505097015777, 5251.343582052244, 5263.473652634706, 5331.573474122061, 73712.26287737161, 75820.24179758242, 130626.0, 131260.3436982809, 133189.0, 116622.0, 117391.41304293423, 117525.4123729393, 118710.40644796721, 120410.0, 57381.71309143511, 59075.0, 61493.69253153705, 93479.5326023352, 100681.0, 10234.232432567736, 10966.506507207036, 11042.0, 11044.723881902695, 11223.88776112261, 54358.45641543534, 54395.18407223815, 55227.44772552223, 55247.723761380934, 56819.14771278352, 70426.64786676034, 72064.63967680128, 76458.0, 81518.0, 82117.58941205256, 13879.930600346934, 14136.858631413554, 14367.28163591837, 14464.27678616086, 14766.114033157615, 16130.919345403197, 16268.773761899336, 16561.337546498005, 17048.744268836224, 17713.734293985344, 13644.795328069888, 13752.518661846787, 14528.346224419714, 14612.561623151323, 14838.258087095817, 14815.0, 15108.924455378092, 15118.168500732565, 15232.238388080774, 15465.690686186439, 14787.852121478647, 15297.235138243266, 15679.451219207273, 15708.450204242796, 15977.0, 11725.92699552376, 11821.75871533511, 11998.76002479963, 12293.508259669514, 12527.0, 13188.868111318763, 13313.800292995418, 13350.132241404666, 13407.86592134066, 13420.194788312732], "value": 8263.369064485893, "unit": "score"}], "name": "dromaeo_css", "value": 7734.927829106323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 108.0, 108.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 122.0, 153.0, 123.0, 118.0, 117.0, 117.0, 149.0, 119.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 109.0, 76.0, 76.0, 76.0, 76.0, 111.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 111.0, 81.0, 82.0, 81.0, 100.0, 83.0, 81.0, 103.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "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, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 56.0, 49.0, 50.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 72.0, 74.0, 72.0, 82.0, 76.0, 72.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 129.0, 121.0, 127.0, 118.0, 127.0, 117.0, 156.0, 125.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 159.0, 153.0, 158.0, 155.0, 152.0, 154.0, 163.0, 151.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1457.0, "alertThreshold": 2.0}]} 04:41:30 INFO - Return code: 0 04:41:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:30 INFO - # TBPL SUCCESS # 04:41:30 INFO - Running post-action listener: _resource_record_post_action 04:41:30 INFO - [mozharness: 2016-11-14 12:41:30.456621Z] Finished run-tests step (success) 04:41:30 INFO - Running post-run listener: _resource_record_post_run 04:41:30 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368422912; Read time: 8; Write time: 330232 04:41:30 INFO - TinderboxPrint: CPU usage
13.0% 04:41:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:41:30 INFO - TinderboxPrint: I/O write bytes / time
368,422,912 / 330,232 04:41:30 INFO - TinderboxPrint: CPU idle
8,260.4 (87.0%) 04:41:30 INFO - TinderboxPrint: CPU user
1,191.2 (12.5%) 04:41:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:41:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118812672; Read time: 0; Write time: 100524 04:41:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249610240; Read time: 0; Write time: 229708 04:41:31 INFO - Running post-run listener: _upload_blobber_files 04:41:31 INFO - Blob upload gear active. 04:41:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:31 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 04:41:31 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'] 04:41:31 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 04:41:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:32 INFO - (blobuploader) - INFO - Done attempting. 04:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:35 INFO - (blobuploader) - INFO - Done attempting. 04:41:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:36 INFO - (blobuploader) - INFO - Done attempting. 04:41:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:36 INFO - Return code: 0 04:41:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab2804587bacab5133bdf7adf9656378f912a1529aa4f5508ee4a41db879fafcc0217d45db581f73c26cce4f7cac005b6281949eab0144ed31d2bb23af41959b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/433f134b300dbf173b719c2f92dbd2027e423a4773898c3ae52c62dea96e33c1babe2269f81d40a11f6099257b8defe11f8a96255d8059882b198671109c80d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a35baa240d2aa44b770ebd9f269197276db621dd924fe1a0e78396454b5c18b678edbe7f87b5572165faaecd7473926f65618e73ce01139b8e3c6f3fa7281aaa"} 04:41:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:36 INFO - Contents: 04:41:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab2804587bacab5133bdf7adf9656378f912a1529aa4f5508ee4a41db879fafcc0217d45db581f73c26cce4f7cac005b6281949eab0144ed31d2bb23af41959b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/433f134b300dbf173b719c2f92dbd2027e423a4773898c3ae52c62dea96e33c1babe2269f81d40a11f6099257b8defe11f8a96255d8059882b198671109c80d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a35baa240d2aa44b770ebd9f269197276db621dd924fe1a0e78396454b5c18b678edbe7f87b5572165faaecd7473926f65618e73ce01139b8e3c6f3fa7281aaa"} 04:41:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:36 INFO - Copying logs to upload dir... 04:41:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.321472 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 04:41:35.753188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 04:41:35.760429) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 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/ab2804587bacab5133bdf7adf9656378f912a1529aa4f5508ee4a41db879fafcc0217d45db581f73c26cce4f7cac005b6281949eab0144ed31d2bb23af41959b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/433f134b300dbf173b719c2f92dbd2027e423a4773898c3ae52c62dea96e33c1babe2269f81d40a11f6099257b8defe11f8a96255d8059882b198671109c80d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a35baa240d2aa44b770ebd9f269197276db621dd924fe1a0e78396454b5c18b678edbe7f87b5572165faaecd7473926f65618e73ce01139b8e3c6f3fa7281aaa"} build_url:https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011811 build_url: 'https://queue.taskcluster.net/v1/task/WAT0cOieRYyaK4hOwlJ1vg/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/ab2804587bacab5133bdf7adf9656378f912a1529aa4f5508ee4a41db879fafcc0217d45db581f73c26cce4f7cac005b6281949eab0144ed31d2bb23af41959b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/433f134b300dbf173b719c2f92dbd2027e423a4773898c3ae52c62dea96e33c1babe2269f81d40a11f6099257b8defe11f8a96255d8059882b198671109c80d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a35baa240d2aa44b770ebd9f269197276db621dd924fe1a0e78396454b5c18b678edbe7f87b5572165faaecd7473926f65618e73ce01139b8e3c6f3fa7281aaa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 04:41:35.785783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:41:35.786120) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1479125472.760009-727530465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 04:41:35.872842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 04:41:35.873597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 04:41:35.874278) ========= ========= Total master_lag: 0.18 =========