builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1477598669.71 results: success (0) buildid: 20161027100034 builduid: 74f272c1157d4071b3660cd0db382199 revision: 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.708308) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.708804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.709121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.724489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.724870) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 13:04:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-27 13:04:29 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.818345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.818685) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015431 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:29.869530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:04:29.870179) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 --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 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 --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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 13:04:29,987 truncating revision to first 12 chars 2016-10-27 13:04:29,987 Setting DEBUG logging. 2016-10-27 13:04:29,987 attempt 1/10 2016-10-27 13:04:29,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/85a4c1dae591?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 13:04:30,556 unpacking tar archive at: mozilla-aurora-85a4c1dae591/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:04:30.876098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:30.876480) ========= script_repo_revision: 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:30.876921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:30.877187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:04:30.886292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-27 13:04:30.886570) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:04:31 INFO - MultiFileLogger online at 20161027 13:04:31 in /builds/slave/test 13:04:31 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 13:04:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:04:31 INFO - {'append_to_log': False, 13:04:31 INFO - 'base_work_dir': '/builds/slave/test', 13:04:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:04:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:04:31 INFO - 'branch': 'Mozilla-Aurora', 13:04:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:31 INFO - 'config_files': ('talos/linux_config.py',), 13:04:31 INFO - 'default_actions': ('clobber', 13:04:31 INFO - 'read-buildbot-config', 13:04:31 INFO - 'download-and-extract', 13:04:31 INFO - 'populate-webroot', 13:04:31 INFO - 'create-virtualenv', 13:04:31 INFO - 'install', 13:04:31 INFO - 'run-tests'), 13:04:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:31 INFO - 'download_minidump_stackwalk': True, 13:04:31 INFO - 'download_symbols': 'ondemand', 13:04:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:31 INFO - 'installer_path': 'installer.exe', 13:04:31 INFO - 'log_level': 'info', 13:04:31 INFO - 'log_name': 'talos', 13:04:31 INFO - 'log_to_console': True, 13:04:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:04:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:04:31 INFO - 'opt_config_files': (), 13:04:31 INFO - 'pip_index': False, 13:04:31 INFO - 'sps_profile': False, 13:04:31 INFO - 'sps_profile_interval': 0, 13:04:31 INFO - 'suite': 'dromaeojs', 13:04:31 INFO - 'system_bits': '32', 13:04:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:31 INFO - 'title': 'talos-linux64-ix-033', 13:04:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:31 INFO - 'use_talos_json': True, 13:04:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:04:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:31 INFO - 'work_dir': 'build'} 13:04:31 INFO - [mozharness: 2016-10-27 20:04:31.095897Z] Running clobber step. 13:04:31 INFO - Running pre-action listener: _resource_record_pre_action 13:04:31 INFO - Running main action method: clobber 13:04:31 INFO - rmtree: /builds/slave/test/build 13:04:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:04:31 INFO - Running post-action listener: _resource_record_post_action 13:04:31 INFO - [mozharness: 2016-10-27 20:04:31.553461Z] Finished clobber step (success) 13:04:31 INFO - [mozharness: 2016-10-27 20:04:31.553561Z] Running read-buildbot-config step. 13:04:31 INFO - Running pre-action listener: _resource_record_pre_action 13:04:31 INFO - Running main action method: read_buildbot_config 13:04:31 INFO - Using buildbot properties: 13:04:31 INFO - { 13:04:31 INFO - "project": "", 13:04:31 INFO - "product": "firefox", 13:04:31 INFO - "script_repo_revision": "production", 13:04:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:04:31 INFO - "repository": "", 13:04:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:04:31 INFO - "buildid": "20161027100034", 13:04:31 INFO - "pgo_build": "True", 13:04:31 INFO - "basedir": "/builds/slave/test", 13:04:31 INFO - "buildnumber": 598, 13:04:31 INFO - "slavename": "talos-linux64-ix-033", 13:04:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:04:31 INFO - "platform": "ubuntu64_hw", 13:04:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:04:31 INFO - "branch": "mozilla-aurora", 13:04:31 INFO - "repo_path": "releases/mozilla-aurora", 13:04:31 INFO - "revision": "85a4c1dae5915173009cb5bdf4f5478eab6f8b42", 13:04:31 INFO - "stage_platform": "linux64-pgo", 13:04:31 INFO - "builduid": "74f272c1157d4071b3660cd0db382199", 13:04:31 INFO - "slavebuilddir": "test" 13:04:31 INFO - } 13:04:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 13:04:31 INFO - Running post-action listener: _resource_record_post_action 13:04:31 INFO - [mozharness: 2016-10-27 20:04:31.555985Z] Finished read-buildbot-config step (success) 13:04:31 INFO - [mozharness: 2016-10-27 20:04:31.556075Z] Running download-and-extract step. 13:04:31 INFO - Running pre-action listener: _resource_record_pre_action 13:04:31 INFO - Running main action method: download_and_extract 13:04:31 INFO - mkdir: /builds/slave/test/build/tests 13:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:31 INFO - trying https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 13:04:31 INFO - Downloading https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/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 13:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/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 13:04:32 INFO - Downloaded 1361 bytes. 13:04:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 13:04:32 INFO - Using the following test package requirements: 13:04:32 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 13:04:32 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:04:32 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:04:32 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'jsshell-linux-x86_64.zip'], 13:04:32 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:04:32 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 13:04:32 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:04:32 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:04:32 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:04:32 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 13:04:32 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:04:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:04:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 13:04:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:32 INFO - Fetch https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:04:32 INFO - Expected file size: 21892854 13:04:37 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 13:04:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 13:04:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:37 INFO - Fetch https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:04:37 INFO - Expected file size: 21892854 13:04:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 13:04:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:04:42 INFO - Fetch https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 13:04:42 INFO - Expected file size: 14414081 13:04:43 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')]} 13:04:43 INFO - trying https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 13:04:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/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 13:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/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 13:04:44 INFO - Downloaded 63950916 bytes. 13:04:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 13:04:44 INFO - mkdir: /builds/slave/test/properties 13:04:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:04:44 INFO - Writing to file /builds/slave/test/properties/build_url 13:04:44 INFO - Contents: 13:04:44 INFO - build_url:https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 13:04:45 INFO - Running post-action listener: _resource_record_post_action 13:04:45 INFO - Running post-action listener: set_extra_try_arguments 13:04:45 INFO - [mozharness: 2016-10-27 20:04:45.165482Z] Finished download-and-extract step (success) 13:04:45 INFO - [mozharness: 2016-10-27 20:04:45.165710Z] Running populate-webroot step. 13:04:45 INFO - Running pre-action listener: _resource_record_pre_action 13:04:45 INFO - Running main action method: populate_webroot 13:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:45 INFO - '--tppagecycles', 13:04:45 INFO - '7'], 13:04:45 INFO - 'tests': ['tsvgm']}}, 13:04:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:04:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:04:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:04:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['damp', 'tps']}, 13:04:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['damp', 'tps']}, 13:04:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['dromaeo_dom']}, 13:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['basic_compositor_video']}, 13:04:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:04:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tsvgx', 13:04:45 INFO - 'tsvgr_opacity', 13:04:45 INFO - 'tart', 13:04:45 INFO - 'tscrollx', 13:04:45 INFO - 'cart']}, 13:04:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:04:45 INFO - 'tsvgr_opacity', 13:04:45 INFO - 'tart', 13:04:45 INFO - 'tscrollx', 13:04:45 INFO - 'cart']}, 13:04:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tp5o']}, 13:04:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['tp5o']}, 13:04:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s', 13:04:45 INFO - '--xperf_path', 13:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:45 INFO - 'tests': ['tp5n']}, 13:04:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--xperf_path', 13:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:45 INFO - 'tests': ['tp5n']}}, 13:04:45 INFO - 'talos.zip': {'path': '', 13:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:45 INFO - Running post-action listener: _resource_record_post_action 13:04:45 INFO - [mozharness: 2016-10-27 20:04:45.180824Z] Finished populate-webroot step (success) 13:04:45 INFO - [mozharness: 2016-10-27 20:04:45.180912Z] Running create-virtualenv step. 13:04:45 INFO - Running pre-action listener: _resource_record_pre_action 13:04:45 INFO - Running main action method: create_virtualenv 13:04:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:04:45 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 13:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:04:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:45 INFO - Using real prefix '/usr' 13:04:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:04:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:47 INFO - Installing pip.................done. 13:04:47 INFO - Return code: 0 13:04:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:04:47 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')]} 13:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:47 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')]} 13:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:47 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:47 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 13:04:47 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 13:04:47 INFO - Using env: {'DISPLAY': ':0', 13:04:47 INFO - 'HOME': '/home/cltbld', 13:04:47 INFO - 'LANG': 'en_US.UTF-8', 13:04:47 INFO - 'LANGUAGE': 'en_US:en', 13:04:47 INFO - 'LOGNAME': 'cltbld', 13:04:47 INFO - 'MAIL': '/var/mail/cltbld', 13:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:47 INFO - 'MOZ_NO_REMOTE': '1', 13:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:47 INFO - 'NO_EM_RESTART': '1', 13:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:47 INFO - 'PWD': '/builds/slave/test', 13:04:47 INFO - 'SHELL': '/bin/bash', 13:04:47 INFO - 'SHLVL': '1', 13:04:47 INFO - 'TERM': 'linux', 13:04:47 INFO - 'TMOUT': '86400', 13:04:47 INFO - 'USER': 'cltbld', 13:04:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:47 INFO - '_': '/tools/buildbot/bin/python'} 13:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:48 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 13:04:48 INFO - Cleaning up... 13:04:48 INFO - Return code: 0 13:04:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:04:48 INFO - Using env: {'DISPLAY': ':0', 13:04:48 INFO - 'HOME': '/home/cltbld', 13:04:48 INFO - 'LANG': 'en_US.UTF-8', 13:04:48 INFO - 'LANGUAGE': 'en_US:en', 13:04:48 INFO - 'LOGNAME': 'cltbld', 13:04:48 INFO - 'MAIL': '/var/mail/cltbld', 13:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:48 INFO - 'MOZ_NO_REMOTE': '1', 13:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:48 INFO - 'NO_EM_RESTART': '1', 13:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:48 INFO - 'PWD': '/builds/slave/test', 13:04:48 INFO - 'SHELL': '/bin/bash', 13:04:48 INFO - 'SHLVL': '1', 13:04:48 INFO - 'TERM': 'linux', 13:04:48 INFO - 'TMOUT': '86400', 13:04:48 INFO - 'USER': 'cltbld', 13:04:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:48 INFO - '_': '/tools/buildbot/bin/python'} 13:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:48 INFO - Downloading/unpacking psutil>=3.1.1 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:50 INFO - Installing collected packages: psutil 13:04:50 INFO - Running setup.py install for psutil 13:04:50 INFO - building 'psutil._psutil_linux' extension 13:04:50 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 13:04:50 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 13:04:50 INFO - building 'psutil._psutil_posix' extension 13:04:50 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 13:04:50 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 13:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:50 INFO - Successfully installed psutil 13:04:50 INFO - Cleaning up... 13:04:50 INFO - Return code: 0 13:04:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:04:50 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')]} 13:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:50 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')]} 13:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:50 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:50 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 13:04:50 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 13:04:50 INFO - Using env: {'DISPLAY': ':0', 13:04:50 INFO - 'HOME': '/home/cltbld', 13:04:50 INFO - 'LANG': 'en_US.UTF-8', 13:04:50 INFO - 'LANGUAGE': 'en_US:en', 13:04:50 INFO - 'LOGNAME': 'cltbld', 13:04:50 INFO - 'MAIL': '/var/mail/cltbld', 13:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:50 INFO - 'MOZ_NO_REMOTE': '1', 13:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:50 INFO - 'NO_EM_RESTART': '1', 13:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:50 INFO - 'PWD': '/builds/slave/test', 13:04:50 INFO - 'SHELL': '/bin/bash', 13:04:50 INFO - 'SHLVL': '1', 13:04:50 INFO - 'TERM': 'linux', 13:04:50 INFO - 'TMOUT': '86400', 13:04:50 INFO - 'USER': 'cltbld', 13:04:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:50 INFO - '_': '/tools/buildbot/bin/python'} 13:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:04:52 INFO - Installing collected packages: mozsystemmonitor 13:04:52 INFO - Running setup.py install for mozsystemmonitor 13:04:53 INFO - Successfully installed mozsystemmonitor 13:04:53 INFO - Cleaning up... 13:04:53 INFO - Return code: 0 13:04:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:04:53 INFO - Using env: {'DISPLAY': ':0', 13:04:53 INFO - 'HOME': '/home/cltbld', 13:04:53 INFO - 'LANG': 'en_US.UTF-8', 13:04:53 INFO - 'LANGUAGE': 'en_US:en', 13:04:53 INFO - 'LOGNAME': 'cltbld', 13:04:53 INFO - 'MAIL': '/var/mail/cltbld', 13:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:53 INFO - 'MOZ_NO_REMOTE': '1', 13:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:53 INFO - 'NO_EM_RESTART': '1', 13:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:53 INFO - 'PWD': '/builds/slave/test', 13:04:53 INFO - 'SHELL': '/bin/bash', 13:04:53 INFO - 'SHLVL': '1', 13:04:53 INFO - 'TERM': 'linux', 13:04:53 INFO - 'TMOUT': '86400', 13:04:53 INFO - 'USER': 'cltbld', 13:04:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:53 INFO - '_': '/tools/buildbot/bin/python'} 13:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:04:55 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 13:04:55 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 13:04:55 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 13:04:55 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 13:04:55 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 13:04:55 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 13:04:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:55 INFO - warning: no files found matching '*.txt' 13:04:55 INFO - no previously-included directories found matching 'build' 13:04:55 INFO - no previously-included directories found matching 'dist' 13:04:55 INFO - no previously-included directories found matching '.git*' 13:04:55 INFO - Installing collected packages: jsonschema, functools32 13:04:55 INFO - Running setup.py install for functools32 13:04:55 INFO - warning: no files found matching '*.txt' 13:04:55 INFO - no previously-included directories found matching 'build' 13:04:55 INFO - no previously-included directories found matching 'dist' 13:04:55 INFO - no previously-included directories found matching '.git*' 13:04:55 INFO - Successfully installed jsonschema functools32 13:04:55 INFO - Cleaning up... 13:04:55 INFO - Return code: 0 13:04:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:04:55 INFO - Using env: {'DISPLAY': ':0', 13:04:55 INFO - 'HOME': '/home/cltbld', 13:04:55 INFO - 'LANG': 'en_US.UTF-8', 13:04:55 INFO - 'LANGUAGE': 'en_US:en', 13:04:55 INFO - 'LOGNAME': 'cltbld', 13:04:55 INFO - 'MAIL': '/var/mail/cltbld', 13:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:55 INFO - 'MOZ_NO_REMOTE': '1', 13:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:55 INFO - 'NO_EM_RESTART': '1', 13:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:55 INFO - 'PWD': '/builds/slave/test', 13:04:55 INFO - 'SHELL': '/bin/bash', 13:04:55 INFO - 'SHLVL': '1', 13:04:55 INFO - 'TERM': 'linux', 13:04:55 INFO - 'TMOUT': '86400', 13:04:55 INFO - 'USER': 'cltbld', 13:04:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:55 INFO - '_': '/tools/buildbot/bin/python'} 13:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:04:55 INFO - Cleaning up... 13:04:55 INFO - Return code: 0 13:04:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:04:55 INFO - Using env: {'DISPLAY': ':0', 13:04:55 INFO - 'HOME': '/home/cltbld', 13:04:55 INFO - 'LANG': 'en_US.UTF-8', 13:04:55 INFO - 'LANGUAGE': 'en_US:en', 13:04:55 INFO - 'LOGNAME': 'cltbld', 13:04:55 INFO - 'MAIL': '/var/mail/cltbld', 13:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:55 INFO - 'MOZ_NO_REMOTE': '1', 13:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:55 INFO - 'NO_EM_RESTART': '1', 13:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:55 INFO - 'PWD': '/builds/slave/test', 13:04:55 INFO - 'SHELL': '/bin/bash', 13:04:55 INFO - 'SHLVL': '1', 13:04:55 INFO - 'TERM': 'linux', 13:04:55 INFO - 'TMOUT': '86400', 13:04:55 INFO - 'USER': 'cltbld', 13:04:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:55 INFO - '_': '/tools/buildbot/bin/python'} 13:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 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 13:04:58 INFO - Downloading docopt-0.6.1.tar.gz 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:58 INFO - Running setup.py install for blobuploader 13:04:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:04:58 INFO - Running setup.py install for requests 13:04:59 INFO - Running setup.py install for docopt 13:04:59 INFO - Successfully installed blobuploader requests docopt 13:04:59 INFO - Cleaning up... 13:04:59 INFO - Return code: 0 13:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:59 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')]} 13:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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')]} 13:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:04:59 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 13:04:59 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 13:04:59 INFO - Using env: {'DISPLAY': ':0', 13:04:59 INFO - 'HOME': '/home/cltbld', 13:04:59 INFO - 'LANG': 'en_US.UTF-8', 13:04:59 INFO - 'LANGUAGE': 'en_US:en', 13:04:59 INFO - 'LOGNAME': 'cltbld', 13:04:59 INFO - 'MAIL': '/var/mail/cltbld', 13:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:59 INFO - 'MOZ_NO_REMOTE': '1', 13:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:59 INFO - 'NO_EM_RESTART': '1', 13:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:59 INFO - 'PWD': '/builds/slave/test', 13:04:59 INFO - 'SHELL': '/bin/bash', 13:04:59 INFO - 'SHLVL': '1', 13:04:59 INFO - 'TERM': 'linux', 13:04:59 INFO - 'TMOUT': '86400', 13:04:59 INFO - 'USER': 'cltbld', 13:04:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:59 INFO - '_': '/tools/buildbot/bin/python'} 13:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:59 INFO - Running setup.py (path:/tmp/pip-XWWD_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:59 INFO - Running setup.py (path:/tmp/pip-FfkR52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:59 INFO - Running setup.py (path:/tmp/pip-NH6CeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:59 INFO - Running setup.py (path:/tmp/pip-E4R34s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:59 INFO - Running setup.py (path:/tmp/pip-DZMvYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:00 INFO - Running setup.py (path:/tmp/pip-uGR2QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:00 INFO - Running setup.py (path:/tmp/pip-7m4XTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:00 INFO - Running setup.py (path:/tmp/pip-9yv8L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:00 INFO - Running setup.py (path:/tmp/pip-utJdjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:00 INFO - Running setup.py (path:/tmp/pip-ZKQy3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:00 INFO - Running setup.py (path:/tmp/pip-AfzKya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:00 INFO - Running setup.py (path:/tmp/pip-qCJY5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:00 INFO - Running setup.py (path:/tmp/pip-9Gpo6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:00 INFO - Running setup.py (path:/tmp/pip-T_nhp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:00 INFO - Running setup.py (path:/tmp/pip-gA3Zoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:00 INFO - Running setup.py (path:/tmp/pip-to2XT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:00 INFO - Running setup.py (path:/tmp/pip-GKi4iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:00 INFO - Running setup.py install for manifestparser 13:05:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozcrash 13:05:01 INFO - Running setup.py install for mozdebug 13:05:01 INFO - Running setup.py install for mozdevice 13:05:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozfile 13:05:01 INFO - Running setup.py install for mozhttpd 13:05:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozinfo 13:05:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozInstall 13:05:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozleak 13:05:01 INFO - Running setup.py install for mozlog 13:05:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for moznetwork 13:05:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozprocess 13:05:02 INFO - Running setup.py install for mozprofile 13:05:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozrunner 13:05:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozscreenshot 13:05:02 INFO - Running setup.py install for moztest 13:05:02 INFO - Running setup.py install for mozversion 13:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:02 INFO - Cleaning up... 13:05:02 INFO - Return code: 0 13:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:02 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')]} 13:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:02 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')]} 13:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:02 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:05:02 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 13:05:02 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 13:05:02 INFO - Using env: {'DISPLAY': ':0', 13:05:02 INFO - 'HOME': '/home/cltbld', 13:05:02 INFO - 'LANG': 'en_US.UTF-8', 13:05:02 INFO - 'LANGUAGE': 'en_US:en', 13:05:02 INFO - 'LOGNAME': 'cltbld', 13:05:02 INFO - 'MAIL': '/var/mail/cltbld', 13:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:02 INFO - 'MOZ_NO_REMOTE': '1', 13:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:02 INFO - 'NO_EM_RESTART': '1', 13:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:02 INFO - 'PWD': '/builds/slave/test', 13:05:02 INFO - 'SHELL': '/bin/bash', 13:05:02 INFO - 'SHLVL': '1', 13:05:02 INFO - 'TERM': 'linux', 13:05:02 INFO - 'TMOUT': '86400', 13:05:02 INFO - 'USER': 'cltbld', 13:05:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:02 INFO - '_': '/tools/buildbot/bin/python'} 13:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:02 INFO - Running setup.py (path:/tmp/pip-Hs9ei_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:02 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:03 INFO - Running setup.py (path:/tmp/pip-NNhgc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:03 INFO - Running setup.py (path:/tmp/pip-19izi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:03 INFO - Running setup.py (path:/tmp/pip-hnqVFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:03 INFO - Running setup.py (path:/tmp/pip-4aJYQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:03 INFO - Running setup.py (path:/tmp/pip-AIvU5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:03 INFO - Running setup.py (path:/tmp/pip-mJwUT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:03 INFO - Running setup.py (path:/tmp/pip-RCYNTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:03 INFO - Running setup.py (path:/tmp/pip-Kzo67W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:03 INFO - Running setup.py (path:/tmp/pip-HlAOWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:03 INFO - Running setup.py (path:/tmp/pip-63_dx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:03 INFO - Running setup.py (path:/tmp/pip-Gi2hQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:03 INFO - Running setup.py (path:/tmp/pip-qTFsKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:03 INFO - Running setup.py (path:/tmp/pip-esh6Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:03 INFO - Running setup.py (path:/tmp/pip-iq_RLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:04 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)) 13:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:04 INFO - Running setup.py (path:/tmp/pip-3njUH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:04 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)) 13:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:04 INFO - Running setup.py (path:/tmp/pip-yRS_cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:06 INFO - Downloading blessings-1.6.tar.gz 13:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:06 INFO - Installing collected packages: blessings 13:05:06 INFO - Running setup.py install for blessings 13:05:06 INFO - Successfully installed blessings 13:05:06 INFO - Cleaning up... 13:05:06 INFO - Return code: 0 13:05:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:06 INFO - Reading from file tmpfile_stdout 13:05:06 INFO - Current package versions: 13:05:06 INFO - argparse == 1.2.1 13:05:06 INFO - blessings == 1.6 13:05:06 INFO - blobuploader == 1.2.4 13:05:06 INFO - docopt == 0.6.1 13:05:06 INFO - functools32 == 3.2.3-2 13:05:06 INFO - jsonschema == 2.5.1 13:05:06 INFO - manifestparser == 1.1 13:05:06 INFO - mozInstall == 1.12 13:05:06 INFO - mozcrash == 0.17 13:05:06 INFO - mozdebug == 0.1 13:05:06 INFO - mozdevice == 0.48 13:05:06 INFO - mozfile == 1.2 13:05:06 INFO - mozhttpd == 0.7 13:05:06 INFO - mozinfo == 0.9 13:05:06 INFO - mozleak == 0.1 13:05:06 INFO - mozlog == 3.4 13:05:06 INFO - moznetwork == 0.27 13:05:06 INFO - mozprocess == 0.23 13:05:06 INFO - mozprofile == 0.28 13:05:06 INFO - mozrunner == 6.12 13:05:06 INFO - mozscreenshot == 0.1 13:05:06 INFO - mozsystemmonitor == 0.3 13:05:06 INFO - moztest == 0.7 13:05:06 INFO - mozversion == 1.4 13:05:06 INFO - psutil == 3.1.1 13:05:06 INFO - requests == 1.2.3 13:05:06 INFO - wsgiref == 0.1.2 13:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:06 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')]} 13:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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')]} 13:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:05:06 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 13:05:06 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 13:05:06 INFO - Using env: {'DISPLAY': ':0', 13:05:06 INFO - 'HOME': '/home/cltbld', 13:05:06 INFO - 'LANG': 'en_US.UTF-8', 13:05:06 INFO - 'LANGUAGE': 'en_US:en', 13:05:06 INFO - 'LOGNAME': 'cltbld', 13:05:06 INFO - 'MAIL': '/var/mail/cltbld', 13:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:06 INFO - 'MOZ_NO_REMOTE': '1', 13:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:06 INFO - 'NO_EM_RESTART': '1', 13:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:06 INFO - 'PWD': '/builds/slave/test', 13:05:06 INFO - 'SHELL': '/bin/bash', 13:05:06 INFO - 'SHLVL': '1', 13:05:06 INFO - 'TERM': 'linux', 13:05:06 INFO - 'TMOUT': '86400', 13:05:06 INFO - 'USER': 'cltbld', 13:05:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:06 INFO - '_': '/tools/buildbot/bin/python'} 13:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 INFO - Cleaning up... 13:05:06 INFO - Return code: 0 13:05:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:05:06 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')]} 13:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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')]} 13:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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 0x7ff47c8e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', '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 13:05:06 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 13:05:06 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 13:05:06 INFO - Using env: {'DISPLAY': ':0', 13:05:06 INFO - 'HOME': '/home/cltbld', 13:05:06 INFO - 'LANG': 'en_US.UTF-8', 13:05:06 INFO - 'LANGUAGE': 'en_US:en', 13:05:06 INFO - 'LOGNAME': 'cltbld', 13:05:06 INFO - 'MAIL': '/var/mail/cltbld', 13:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:06 INFO - 'MOZ_NO_REMOTE': '1', 13:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:06 INFO - 'NO_EM_RESTART': '1', 13:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:06 INFO - 'PWD': '/builds/slave/test', 13:05:06 INFO - 'SHELL': '/bin/bash', 13:05:06 INFO - 'SHLVL': '1', 13:05:06 INFO - 'TERM': 'linux', 13:05:06 INFO - 'TMOUT': '86400', 13:05:06 INFO - 'USER': 'cltbld', 13:05:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:06 INFO - '_': '/tools/buildbot/bin/python'} 13:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:05:07 INFO - Cleaning up... 13:05:07 INFO - Return code: 0 13:05:07 INFO - Running post-action listener: _resource_record_post_action 13:05:07 INFO - Running post-action listener: _start_resource_monitoring 13:05:07 INFO - Starting resource monitoring. 13:05:07 INFO - [mozharness: 2016-10-27 20:05:07.059963Z] Finished create-virtualenv step (success) 13:05:07 INFO - [mozharness: 2016-10-27 20:05:07.060421Z] Running install step. 13:05:07 INFO - Running pre-action listener: _resource_record_pre_action 13:05:07 INFO - Running main action method: install 13:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:07 INFO - Reading from file tmpfile_stdout 13:05:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:05:07 INFO - Reading from file tmpfile_stdout 13:05:07 INFO - Output received: 13:05:07 INFO - Usage: mozinstall [options] installer 13:05:07 INFO - Options: 13:05:07 INFO - -h, --help show this help message and exit 13:05:07 INFO - -d DEST, --destination=DEST 13:05:07 INFO - Directory to install application into. [default: 13:05:07 INFO - "/builds/slave/test"] 13:05:07 INFO - --app=APP Application being installed. [default: firefox] 13:05:07 INFO - mkdir: /builds/slave/test/build/application 13:05:07 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'] 13:05:07 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 13:05:23 INFO - Reading from file tmpfile_stdout 13:05:23 INFO - Output received: 13:05:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:05:23 INFO - Running post-action listener: _resource_record_post_action 13:05:23 INFO - [mozharness: 2016-10-27 20:05:23.319751Z] Finished install step (success) 13:05:23 INFO - [mozharness: 2016-10-27 20:05:23.319995Z] Running run-tests step. 13:05:23 INFO - Running pre-action listener: _resource_record_pre_action 13:05:23 INFO - Running main action method: run_tests 13:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:05:23 INFO - Python 2.7.3 13:05:23 INFO - Return code: 0 13:05:23 INFO - grabbing minidump binary from tooltool 13:05: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')]} 13:05:23 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 0x1887f60>, '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 0x1888d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18891d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:05:23 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 13:05:23 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 13:05:23 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 13:05:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:23 INFO - Return code: 0 13:05:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:05:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:05:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:05:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:05:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:05:23 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/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:05:23 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/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 13:05:23 INFO - Using env: {'DISPLAY': ':0', 13:05:23 INFO - 'HOME': '/home/cltbld', 13:05:23 INFO - 'LANG': 'en_US.UTF-8', 13:05:23 INFO - 'LANGUAGE': 'en_US:en', 13:05:23 INFO - 'LOGNAME': 'cltbld', 13:05:23 INFO - 'MAIL': '/var/mail/cltbld', 13:05:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:05:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:23 INFO - 'MOZ_NO_REMOTE': '1', 13:05:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:23 INFO - 'NO_EM_RESTART': '1', 13:05:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:23 INFO - 'PWD': '/builds/slave/test', 13:05:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:05:23 INFO - 'SHELL': '/bin/bash', 13:05:23 INFO - 'SHLVL': '1', 13:05:23 INFO - 'TERM': 'linux', 13:05:23 INFO - 'TMOUT': '86400', 13:05:23 INFO - 'USER': 'cltbld', 13:05:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973', 13:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:23 INFO - '_': '/tools/buildbot/bin/python'} 13:05:23 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/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 13:05:23 INFO - mozversion application_buildid: 20161027100034 13:05:23 INFO - mozversion application_changeset: 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 13:05:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:05:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:23 INFO - mozversion application_name: Firefox 13:05:23 INFO - mozversion application_remotingname: firefox-dev 13:05:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:05:23 INFO - mozversion application_vendor: Mozilla 13:05:23 INFO - mozversion application_version: 51.0a2 13:05:23 INFO - mozversion platform_buildid: 20161027100034 13:05:23 INFO - mozversion platform_changeset: 85a4c1dae5915173009cb5bdf4f5478eab6f8b42 13:05:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:05:23 INFO - mozversion platform_version: 51.0a2 13:05:23 INFO - using testdate: 1477598723 13:05:23 INFO - actual date: 1477598723 13:05:23 INFO - starting webserver on 'localhost:58057' 13:05:23 INFO - SUITE-START | Running 2 tests 13:05:23 INFO - TEST-START | dromaeo_css 13:05:23 INFO - operating with platform_type : linux_ 13:05:23 INFO - Initialising browser for dromaeo_css test... 13:05:23 INFO - TEST-INFO | started process 20499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhJcGN/profile http://localhost:58057/getInfo.html) 13:05:28 INFO - PROCESS | 20499 | __metrics Screen width/height:1600/1200 13:05:28 INFO - PROCESS | 20499 | colorDepth:24 13:05:28 INFO - PROCESS | 20499 | Browser inner width/height: 1024/697 13:05:28 INFO - PROCESS | 20499 | __metrics 13:05:28 INFO - PROCESS | 20499 | 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" 13:05:28 INFO - PROCESS | 20499 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:29 INFO - PROCESS | 20499 | console.error: PushService: 13:05:29 INFO - PROCESS | 20499 | stateChangeProcessEnqueue: Error transitioning state 13:05:29 INFO - PROCESS | 20499 | UnknownError 13:05:29 INFO - TEST-INFO | 20499: exit 0 13:05:29 INFO - Browser initialized. 13:05:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:05:29 INFO - TEST-INFO | started process 20591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhJcGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:41 INFO - PROCESS | 20591 | RSS: Main: 144261120 13:05:41 INFO - PROCESS | 20591 | 13:06:32 INFO - PROCESS | 20591 | 1477598792964 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] 13:08:42 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58057/tests/dromaeo/cssquery-ext.html) 13:08:43 INFO - PROCESS | 20591 | RSS: Main: 244125696 13:08:43 INFO - PROCESS | 20591 | 13:11:45 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-ext.html (next: http://localhost:58057/tests/dromaeo/cssquery-jquery.html) 13:11:46 INFO - PROCESS | 20591 | RSS: Main: 233824256 13:11:46 INFO - PROCESS | 20591 | 13:14:48 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58057/tests/dromaeo/cssquery-mootools.html) 13:14:48 INFO - PROCESS | 20591 | RSS: Main: 174411776 13:14:48 INFO - PROCESS | 20591 | 13:17:50 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58057/tests/dromaeo/cssquery-prototype.html) 13:17:51 INFO - PROCESS | 20591 | RSS: Main: 173596672 13:17:51 INFO - PROCESS | 20591 | 13:20:53 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58057/tests/dromaeo/cssquery-yui.html) 13:20:54 INFO - PROCESS | 20591 | RSS: Main: 175992832 13:20:54 INFO - PROCESS | 20591 | 13:23:56 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:58057/tests/dromaeo/cssquery-yui.html (next: http://localhost:58057/tests/dromaeo/cssquery-dojo.html) 13:23:57 INFO - PROCESS | 20591 | RSS: Main: 268775424 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | __start_tp_report 13:23:57 INFO - PROCESS | 20591 | _x_x_mozilla_page_load 13:23:57 INFO - PROCESS | 20591 | _x_x_mozilla_page_load_details 13:23:57 INFO - PROCESS | 20591 | |i|pagename|runs| 13:23:57 INFO - PROCESS | 20591 | |0;dojo.html;3130.6243250809903;3174.0795169400863;3178.5073313636385;3189.4099591575546;3221.09809253409;5541.695206763627;5598.748056337465;5599.832005039855;5631.127175287832;5641.464060914217;5591.077472217079;5662.631928924617;5662.943370566293;5678;5700.515456186229;5123.743812809364;5144.871378215537;5179.922301165486;5180.30468279225;5227.32044834171;5008.248762685608;5029.798808047673;5238.947610523884;5239.580833533309;5240.633155679085;5049.24261360797;5055.671381360218;5082.974585127069;5098.311727916739;5149.639525233235;5148.974255128719;5165.3026841376495;5252.606054545924;5258.0535503609335;5287.259783630295;4838.080764654705;5125.641205115643;5152.149895267276;5204.089284375219;5216.217567364888;5402.37872644647;5468.371137319219;5490.945090549123;5508.55931525481;5517.337919449652;5895.204147440127;5907.409259074101;6000.699965001732;6001.279846418414;6010.038393856962;5790.478856902899;6041;6050.818475445743;6063.727132279058;6075.908861367083;5463.235147079412;5503.669779813224;5517.889642207174;5560.499555040065;5580.804671836466;6133.754649814046;6138.048602466625;6141.539384546177;6142.355052719489;6147.877042459126;5692.459216374438;5906.734196961147;5910.172575839386;5911.438413350725;5916.881662366729;5800.709964501758;5830.4461076197695;5890.676012819336;5893.057110862242;5997.580169388189;5907.409259074144;5907.61600495975;5908.615939963975;5908.881822363614;5918.8816223675285;5854;5900.439458251545;5911.556633252523;5919.822405327847;5953.493953013955;4482.103579284156;4513.187626227311;4532.954670453253;4577.176108300471;4578.198815207325;4053.017091035938;4081.89795255121;4097.364908439196;4102.261592913304;4120.75275483472;5596.2165296858475;5611.130274807411;5617.578681598897;5620.606557540933;5656.8868622627315;5738.741756620962;5797.826065218051;5932.525397968152;5955.464008239279;5999.640021598718;5680.68756218412;5685.857853553694;5697.373288938214;5711.428857114339;5729.140628905614;5232.502912223333;5246.658967167122;5246.895062098737;5247.895042099213;5267.789288428497;5919.852003699942;6035.60768550034;6105.145279660762;6216.160818289563;6233.501319894398;5938.435848594377;5938.584299099021;6042.123892035543;6072.119542666201;6098.603590766586;6068.302145253352;6071.726772295346;6072.453479186895;6072.787452439144;6073.99779036454;5660.943390566042;5827.475527202572;5828.708564571839;5831.212786273799;5834.212381328466;5873.442023007808;5929.288485381781;5949.167116603766;5977.043673012297;6066.514678825595;5869.970650146722;5870.26621672291;5916.763329466773;5917.082852157922;5926.436988486087;5818.24362832846;5828.708564571839;5845;5849.473547380756;5851.970740146272;5550.722463876871;5665.5750818689585;5769.769209231752;5814.069748840166;5829.038208695518;5953.523718102455;5954.3152537458745;5957.225560677258;5961.2846458425265;5962.19510366095;5586.441355864381;5634.859128521656;5652.547796176378;5792.652440853393;5793.797217097382 13:23:57 INFO - PROCESS | 20591 | |1;ext.html;596.7344531683402;606.8045949479524;623.7473823101644;646.8027251688236;647.7538535356564;34290.31419371611;37625.435618465744;46770.29844552326;47400.52599474004;47454.7627261864;49357.50642493574;49927.50072499274;49962.75018624902;50021.74989125058;50033.49966500334;9366.34435589509;9477.38397004196;9485.146336829685;9521.857172142423;9530.046995300483;8561.785955351135;8756.56217189138;11052.392118433483;11299.49152288145;11304;11440;11514.251573647727;11535.711607209803;11546.24949378292;11549.6535103947;11308.37803920784;11359.488823002985;11369.488373023192;11375.431228438545;11386.829197562043;11260.436978151141;11339.14956378275;11344.262622929566;11359.432028398629;11363.772724545463;46042.53957460416;46268.305975410396;46486.53513464856;46527;46645;3826.885193444201;3865.4008628662323;3883.902902427462;4057.3305404608204;4155.2728272552185;34471.31035511041;34518.309633807185;34543.4818477723;34913;34940.65059349425;4486.461624605068;4638.582527572501;4656.092062047902;4679.602233810097;4687.7656117194;365092;367495;368078.15960920294;368408.9999999973;368975;65952.34047659558;66104.33895661078;66214.33785662179;66294.66852665802;66425;41649.37525937113;42249.36625950613;42655.57344426578;44448;44515.55484445179;19319.710204346946;19496.317628883204;19576.119074641676;19608;19699.11353989074;13942.930285348508;15024.624384390478;15106.320215590325;15121.848781512044;15156.166410847289;18614.720779188323;20405.693914591295;20927.47681307949;20961.37115886526;21682.34952951414;7379.631018449056;7437.665305061285;7512.962435187789;7587.241275872479;7687.692492300357;1128.497818470789;1134.2117228526095;1147.17976646698;1191.666333426642;1209.5826939705787;35292.47061294083;35454.08613122779;35683;35744.46383304252;35764.82117589395;1116.2855772305732;1124.4040658451033;1163.3834067943833;1180.1620849196995;1258.1633213912646;18286.17712202954;18351.908240458713;18422.35521756732;18511.35210267634;18705.719414208797;627192;632291;632399;633050;635996;65151.67424162944;65845;65896.34103658998;66011;66044.66977665178;1312.8687131286795;1345.35422996962;1367.3026756354132;1378.2764048874421;1394.4352537222442;34724.82637586796;35295.64704353026;36266.456003159445;36445.817770912035;36729.44905826468;63216.36783632105;66695;68451;68652.656736716;68666;546274;613332;619683;619843;621970;44911.55088449074;48360;48362.75818620884;48448.5155148444;49057.50942490529;53200.2019969693;53236.46763532315;53607.731961339945;54093.45906540884;54575;44296.92335336556;44860.32709509425;45324.773376134224;46150.53849461462;47798;44886;45146.77426612846;45453.318200226364;45872.08255834931;46084;44457;44594.3310850344;44801.10397792091;44980.550194497635;46485.767571163284;38219.42670859884;39549;39986.40020399638;40374;41111;30026.87599918807;30038.849805750833;30348.24129396783;30582.541261881535;30791.53812692856 13:23:57 INFO - PROCESS | 20591 | |2;jquery.html;376.2253381312816;398.4660554856492;420.5941266677655;426.53720713026365;426.94449721536193;14451.927740361296;16383.590410239734;20186.59626807463;20906.68639970398;21074.15703371867;17963.281468741236;18468.538286542844;18737.718934215998;20826.791732082675;21009;5743.798967036155;5787.768489260425;5891.88216235675;5951.702414879261;6012.669303188323;4263.403123562688;5831.30024397073;5917.852053698649;5922.1116832475045;5924.58527903047;4436.778161091948;6222.377762223764;6461.386168314003;6522.902156467657;6626.8674626507445;6432.228132624092;6597.274299827015;6608.537402381835;6613.900791488131;6649.567778094409;5896.941030589682;5923.911141332884;5925.8814823703715;5926.111083337534;5928.170056192136;22773.772262277333;23545.76454235453;25328;25372.619410708856;25664.615030774552;2432.902683892642;2618.463215040912;2642.2205449392477;2973.613430254075;3082.368114536537;10500.159987201081;10575.101116405114;10661.680149595524;13779.448822047207;15201.771973420407;1987.7714062882808;2003.9539899353047;2062.0308455026116;2075.190675636503;2086.3636590839787;86961.13038869656;89885;91486.5425672874;92187;96446;11515.136364772676;11700.94149529264;11712.355820429788;11721.589744358907;11763.823542646867;16700.58248543796;16801.91599041997;16824.411145609844;16840.24218910152;16865.747013794804;8695.565241732325;9032.187103160748;9036.81926361469;9046.185843274137;9098.272138228926;8554.529500877512;8724.476531408136;8739.563021848882;8780.770692103111;8860.069692682304;4998.750062496861;5159.432462429129;5167.534921856975;5195.662281951737;5239.1093514102695;1991.4722598511405;2085.9269925552535;2112.6619740841393;2132.6267903117205;2164.1018977124318;908.7001289574557;980.9313348065567;1020.4948550467418;1021.9642312519026;1022.8619136416637;20016.799832001783;20279.510856001998;20818;20894.895525522275;21212.151513939578;993.3791380387258;997.0229175408141;1034.5137785240925;1035.0736091198335;1039.2725092435326;10149.492525373702;11191.496382662799;11398;11461.426928653535;11488.310701357945;511425;522594;527706;535678;559844;97190;100359.49820250852;101479;103135.4843225779;105716.47141764396;992.8411454167299;1037.8080055189814;1045.163868904858;1051.6844946516014;1066.0352381095122;17511;17866.642667146843;18215.544611384823;18350.082495874885;18357.173927173044;33261.833690831394;38948.6105138945;42518.78740606277;44026.77986610046;45168.32247516356;55942.042028528806;60134.39865601288;61503.692481537306;62043;62092.37907620866;8087.3125784308995;8912.28701703875;9027.548622568976;9096.54517274147;9138.31462640318;13093.476260949836;13168.736625267633;13331.200127991964;13515.86484135146;13840.23878686682;11597.5360985563;11685.123615728684;11835.704107397383;11857;11922.4038798058;10974.780504390028;11200.439978000904;11255.774884502427;11712.297262164297;11911;11609.6517104487;11664.125190610908;11793.646190614296;11997.520099195934;12191.573294934635;9017.774555635899;9146.725598232064;9313.208377287736;9372.109649583279;9401.905980940102;10526.31578947366;11783.587574434854;11853.644390668294;11905.702357441134;12023.75952480963 13:23:57 INFO - PROCESS | 20591 | |3;mootools.html;1345.5626921250596;1521.3382178752245;1541.7533194688851;1723.741438784183;1868.9813101868976;7594.962025189873;8739.431936924095;9004.8649270261;9009.684661036865;9330.626774928995;9058.365914385995;9118.133777291163;9141.862872056925;9142.588583513758;9147.908520914789;2482.5159093976636;2512.623106534016;2512.994802079174;2515.76100270474;2516.9748302517014;2394.6048901931163;2472;2475.752424757519;2476.5046990601863;2476.8513889166707;2438.8048956083558;2458.409981604411;2458.545169143705;2458.7172475165316;2460.1758410932357;2368.834181607288;2388.7014123234594;2399.436132508859;2402.6636270922086;2405.7113146422366;2380.845245059083;2390.438247011951;2392.2823153054187;2393.066703985447;2395.8083353331867;8642.827143457096;8809.163129502687;8825.161609647073;8829.779255518599;8879.51162686052;5233.921491177635;5408.215808707715;5410.83767486976;5416.91874621881;5426.158945363475;3579.1052236940764;3594.7843129412317;3648.908777280563;3667.468217108504;3667.7065834733157;1285.1325355385077;1288.22062652096;1294.3140135728079;1315.6316231455112;1324.8675132486674;12555.497780088786;12625.621231362982;12671.239725616493;12684.936575317157;12704.475462944414;4716.693414928019;4730.148573256847;4761.316526749058;4822.590079843252;4944.159492886218;9844.261680374;9908.851367229498;10006.44964526958;10010.249231307535;10024.699259022242;5503.6147469677535;5520.613557051048;5521.4478552145265;5528.668279903219;5529.612927095145;4285.7642829644665;4407.669424793154;4957.3307603473795;5065.772040258197;5074.08666440037;3938.074552480165;3989.0226894410475;4051.777152256654;4082.693797965105;4087.754734715867;1245.8442694663167;1262.4066688656317;1274.7386785708907;1275.43880692495;1281.8782215689494;925.4493576322078;1024.2369434771142;1026.9024442677933;1029.5006921642996;1036.5853658536646;5943.108533719977;6070.848228794315;6071.241094863142;6127.234095738033;6253.312135665074;998.8501724741346;1012.1245122968726;1013.533774463755;1045.5869931377063;1048.5229220704562;4202.873913782591;4340.153670034376;4352.412424322676;4368.27923392643;4504.61710754583;10644.733881652866;10942.726431839108;11033.503492342703;11045.558177672963;11046.558137674403;10971.177161712903;10972.177086718368;10984.670459886216;10997.395143267036;11003;8105.1489593593005;8382.49705017701;8399.076101628816;8607.311415086904;8607.526586037702;6004.639721616542;6069.119977603311;6193.163922870535;6325.873482530232;6330.52521060913;10198.18414526851;10432.113270372103;10560.471976400995;10592.364458132537;10650.414227217578;10383.94808025955;10445.843312350473;10561.63034293796;10605.098566621615;10653.414062226342;6844.178698556205;7476.813079672834;7902.170272121574;7968.641411136628;8092.595370231583;8851.424657397249;8927.196552310323;8936.597853096757;8940.195382415613;8945.23965462917;7649.923500765144;7884.29041386278;7945.0863150738405;8006;8006.039275287003;7705.922940770521;7706.7687969361;7735.613219338898;7823.2567906048835;7899.763007109796;7188.209296977224;7295.051643286339;7295.161056478573;7295.598742069024;7300.853982920205;5373.382061063028;5498.092814685532;5510.311211098613;5523.116301391758;5669.773209071591;5533.806316778893;5557;5697.6296540724725;5732.541396688338;5914.34942156371 13:23:57 INFO - PROCESS | 20591 | |4;prototype.html;353.8637624514562;359.2312451354102;360.6591770776617;361.56973201889747;368.9760165589235;5459.5905307101975;5498.725063746807;5504.17437384392;5521.365043020054;5557.194206840006;5454.672719636825;5457.208704737811;5466.562674986001;5481.890362192754;5503.229547863302;4035.7982100894983;4141.337386018237;4221.957780422203;4242.97878510607;4306.138772245547;4274.187904298189;4276.524599013335;4283.357496375537;4286.914261714764;4294.463192100988;4280.293751530994;4283.01490657149;4285.700000999916;4288.1423715256915;4299.731579184133;4030.7581545107387;4139.958600413987;4204.138151678899;4263.275243208662;4264.488261408651;3776.433534969749;3787.696984241254;3791.109089363997;3794.5256842894637;3798.442638518194;5291.656042357273;5305.893882122375;5305.920411193797;5307.310049693554;5314.202869569557;4751.881202969919;4853.805847766085;4863.8784030399165;4866.245731911559;4883.633727470454;5654.943450565483;5670.68811215383;5671;5678.659280443146;5689.715514224314;4142.730722503027;4143.482064741907;4148.647364973951;4160.750354978711;4162.334026555767;5786.826395208151;5876.61801982874;5892.381299963485;5902.734376953047;5914.319853216849;4204.873853784391;4215.557366476537;4228.985043589516;4231;4234.407182994383;4257.212415703105;4260.68044896634;4265.3815196796295;4278.63631591312;4292.506361768436;4747.074320507468;4793.158909501429;4861.1006963711825;4866.732329721828;4870.537298956593;5715.228444160069;5739.368669446358;5745.712714364265;5751.166080918243;5774.942250577525;1503.9774403383958;1514.8485151484763;1515.1969456188237;1517.8026856508584;1522.2464879884308;948.6015873333216;973.868527748759;975.4244995452717;995.6913356859396;1003.5584342889106;5298;5349.304590403222;5499.367572729107;5505.513511351993;5526.364468086141;5807.361190269067;5815.3021637402935;5818.738156782955;5842.737076831553;5842.970785146047;5219.269302297681;5368.1679339702405;5445.863853403617;5450.672959622356;5473.452654734574;3049.4968330225706;3068.8951977288157;3069.6009518762417;3075.938481230363;3095.1797773590015;5858.179854820329;5973.522118230618;6006.279246490361;6016.338202797689;6024.819255422344;5876.236089308362;5927.436893495111;5966.701664916824;5975.970120149372;5992.280926288786;5969.776195879835;5978.970105149447;5982.820515384546;5983.341832398432;6012.9098063529955;5559.972200138974;5748.45389687979;5790.363060063474;5811.854703632443;5853.736581853912;5748.626339287933;5752.734398432338;5754.338251101177;5759.452851979056;5767.798127065533;5804.477597016289;5889.823305300848;5915.171875937286;5936.940630593639;5969.313528944227;4257.382679511392;4315.482142142963;4320.200762858881;4345.152695224401;4350.499692535399;5745.621050947826;5816.214811000461;5817.5345972321265;5820.679862607428;5820.73806678692;5395.8775851739565;5638.21065050885;5642.633228840113;5651.491365777099;5655.388214358888;5576.553875689854;5577.609567330248;5601.383847776659;5602.327720673546;5635.351934527418;5599.1041433370465;5606.831795046155;5613.915791263216;5623.509769911058;5625.046850403571;5345.358556973188;5455.236266922555;5578.748956297058;5675.764814056113;5692.743826527899;5567.638103523258;5581.734685209198;5583.385827558884;5591.10542313228;5604.103343465026 13:23:57 INFO - PROCESS | 20591 | |5;yui.html;826.9415148609778;838.3125836813813;855.1533981358457;881.5548148185165;914.6432891172448;14757.335919883604;15022.624434389145;15173;15247.695046099072;15395.153266570349;14258.786118208236;14429.062110962781;14583.125012499231;14587.41650333988;14731.631709207275;844.7043534762814;870.9695160669378;872.8690696395528;873.2271939333704;873.6942070275385;707.345705222667;730.6127752291268;848.3891598049395;870.6734974384606;874.9737507874742;912.8721978922923;918.6279556779515;919.3886065766258;919.5815903763771;919.9770005749842;911.9316051296146;915.3409545127497;916.3631276263;916.903725108864;917.1104029091771;548.4214154067457;561.0462214235815;656.3469347998724;668.8595394967014;671.6473851228095;14819.851801481955;14829.703405931821;14850.331735071839;14864.554063378117;14910.403583856632;15259.389624415011;15757.60605984848;15967.281472333656;16260.75608865868;16299.755503667455;12909.289989050598;12964.351782410937;13037.282949437777;13098.410571524304;13330.86669133306;4720.976395118037;4740.502247264022;4779.952200477986;4806.543378379049;4825.541573550507;90266;90748;91460;93486.5325673374;94903;12445.191062580903;12556.874431255754;12633.684157896127;12722.860538827368;12778.424970876333;23986;24149.396265093514;24244.39389015289;24278.514429711307;24378.634320485206;8856.291496680251;9014.819703606023;9253.306002049738;9425.528723563932;9571.28215383849;4783.617310615143;5018.5985121190215;5068.41713202979;5090.618203634742;5247.10799164143;3675.7794532328144;3785.734998550075;3814.1418180909627;3814.828332725034;3817.9809100954317;623.3921926122085;626.9529785266124;629.7606909374408;638.4254171245916;645.2643985856128;626.7242413338208;642.6947200079925;699.6886385558479;709.7515869445756;721.2030706069822;9901.801963960825;9918.950405248072;10045.849312260321;10111.949440252753;10444.947775261075;645.6287634610118;662.1663147669051;710.6852323202035;748.4424104042523;750.3996802557932;4483.7533935633855;4538.546145385501;4544.840930567414;4733.36099626546;4867.464578896319;80383;81460;92975;134282;140146;111936.44031779951;113405;117945;119761;119963;96753.0324696758;97650;98967;101289.49355253177;106374;9044.683436079706;9226.446413215228;9332.440053596805;9373.906260937576;9435.905640943503;49926.500734993635;59725;60438.69780651069;61494;62086;81541.18458815335;86708;86926.5653671753;88276;91726.54136729274;12867.420966056738;12972;13154.408051637507;13194;13341.399637016551;14199.858001419854;14267.42930282777;14436.783448248494;14532;14728.484503042342;13128.474861005834;13470.52853150135;13873.722525549634;13969.371378288204;14424.567262982127;13012.544560940321;13175.407106680032;13220.074594778273;13627.38676759568;13821.378037988114;13348.065635405817;13354.866451335361;13457.192568445924;13513.662158446117;13809;11033.227674062739;11344.659660210207;11451.625804903464;11471.369074700971;11695;11239.55041798319;11417.657470275904;11504.680630464394;11702.122340824302;11746.882531174579 13:23:57 INFO - PROCESS | 20591 | __end_tp_report 13:23:57 INFO - PROCESS | 20591 | __start_cc_report 13:23:57 INFO - PROCESS | 20591 | _x_x_mozilla_cycle_collect,848 13:23:57 INFO - PROCESS | 20591 | __end_cc_report 13:23:57 INFO - PROCESS | 20591 | __startTimestamp1477599837201__endTimestamp 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | ------- Summary: start ------- 13:23:57 INFO - PROCESS | 20591 | Number of tests: 6 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#0] dojo.html Cycles:165 Average:5545.55 Median:5738.74 stddev:620.30 (10.8%) stddev-sans-first:592.57 13:23:57 INFO - PROCESS | 20591 | Values: 3130.6 3174.1 3178.5 3189.4 3221.1 5541.7 5598.7 5599.8 5631.1 5641.5 5591.1 5662.6 5662.9 5678.0 5700.5 5123.7 5144.9 5179.9 5180.3 5227.3 5008.2 5029.8 5238.9 5239.6 5240.6 5049.2 5055.7 5083.0 5098.3 5149.6 5149.0 5165.3 5252.6 5258.1 5287.3 4838.1 5125.6 5152.1 5204.1 5216.2 5402.4 5468.4 5490.9 5508.6 5517.3 5895.2 5907.4 6000.7 6001.3 6010.0 5790.5 6041.0 6050.8 6063.7 6075.9 5463.2 5503.7 5517.9 5560.5 5580.8 6133.8 6138.0 6141.5 6142.4 6147.9 5692.5 5906.7 5910.2 5911.4 5916.9 5800.7 5830.4 5890.7 5893.1 5997.6 5907.4 5907.6 5908.6 5908.9 5918.9 5854.0 5900.4 5911.6 5919.8 5953.5 4482.1 4513.2 4533.0 4577.2 4578.2 4053.0 4081.9 4097.4 4102.3 4120.8 5596.2 5611.1 5617.6 5620.6 5656.9 5738.7 5797.8 5932.5 5955.5 5999.6 5680.7 5685.9 5697.4 5711.4 5729.1 5232.5 5246.7 5246.9 5247.9 5267.8 5919.9 6035.6 6105.1 6216.2 6233.5 5938.4 5938.6 6042.1 6072.1 6098.6 6068.3 6071.7 6072.5 6072.8 6074.0 5660.9 5827.5 5828.7 5831.2 5834.2 5873.4 5929.3 5949.2 5977.0 6066.5 5870.0 5870.3 5916.8 5917.1 5926.4 5818.2 5828.7 5845.0 5849.5 5852.0 5550.7 5665.6 5769.8 5814.1 5829.0 5953.5 5954.3 5957.2 5961.3 5962.2 5586.4 5634.9 5652.5 5792.7 5793.8 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#1] ext.html Cycles:180 Average:70751.86 Median:41949.37 stddev:145873.17 (347.7%) stddev-sans-first:146187.28 13:23:57 INFO - PROCESS | 20591 | Values: 596.7 606.8 623.7 646.8 647.8 34290.3 37625.4 46770.3 47400.5 47454.8 49357.5 49927.5 49962.8 50021.7 50033.5 9366.3 9477.4 9485.1 9521.9 9530.0 8561.8 8756.6 11052.4 11299.5 11304.0 11440.0 11514.3 11535.7 11546.2 11549.7 11308.4 11359.5 11369.5 11375.4 11386.8 11260.4 11339.1 11344.3 11359.4 11363.8 46042.5 46268.3 46486.5 46527.0 46645.0 3826.9 3865.4 3883.9 4057.3 4155.3 34471.3 34518.3 34543.5 34913.0 34940.7 4486.5 4638.6 4656.1 4679.6 4687.8 365092.0 367495.0 368078.2 368409.0 368975.0 65952.3 66104.3 66214.3 66294.7 66425.0 41649.4 42249.4 42655.6 44448.0 44515.6 19319.7 19496.3 19576.1 19608.0 19699.1 13942.9 15024.6 15106.3 15121.8 15156.2 18614.7 20405.7 20927.5 20961.4 21682.3 7379.6 7437.7 7513.0 7587.2 7687.7 1128.5 1134.2 1147.2 1191.7 1209.6 35292.5 35454.1 35683.0 35744.5 35764.8 1116.3 1124.4 1163.4 1180.2 1258.2 18286.2 18351.9 18422.4 18511.4 18705.7 627192.0 632291.0 632399.0 633050.0 635996.0 65151.7 65845.0 65896.3 66011.0 66044.7 1312.9 1345.4 1367.3 1378.3 1394.4 34724.8 35295.6 36266.5 36445.8 36729.4 63216.4 66695.0 68451.0 68652.7 68666.0 546274.0 613332.0 619683.0 619843.0 621970.0 44911.6 48360.0 48362.8 48448.5 49057.5 53200.2 53236.5 53607.7 54093.5 54575.0 44296.9 44860.3 45324.8 46150.5 47798.0 44886.0 45146.8 45453.3 45872.1 46084.0 44457.0 44594.3 44801.1 44980.6 46485.8 38219.4 39549.0 39986.4 40374.0 41111.0 30026.9 30038.8 30348.2 30582.5 30791.5 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#2] jquery.html Cycles:180 Average:31109.24 Median:12989.33 stddev:87793.13 (675.9%) stddev-sans-first:88009.08 13:23:57 INFO - PROCESS | 20591 | Values: 376.2 398.5 420.6 426.5 426.9 14451.9 16383.6 20186.6 20906.7 21074.2 17963.3 18468.5 18737.7 20826.8 21009.0 5743.8 5787.8 5891.9 5951.7 6012.7 4263.4 5831.3 5917.9 5922.1 5924.6 4436.8 6222.4 6461.4 6522.9 6626.9 6432.2 6597.3 6608.5 6613.9 6649.6 5896.9 5923.9 5925.9 5926.1 5928.2 22773.8 23545.8 25328.0 25372.6 25664.6 2432.9 2618.5 2642.2 2973.6 3082.4 10500.2 10575.1 10661.7 13779.4 15201.8 1987.8 2004.0 2062.0 2075.2 2086.4 86961.1 89885.0 91486.5 92187.0 96446.0 11515.1 11700.9 11712.4 11721.6 11763.8 16700.6 16801.9 16824.4 16840.2 16865.7 8695.6 9032.2 9036.8 9046.2 9098.3 8554.5 8724.5 8739.6 8780.8 8860.1 4998.8 5159.4 5167.5 5195.7 5239.1 1991.5 2085.9 2112.7 2132.6 2164.1 908.7 980.9 1020.5 1022.0 1022.9 20016.8 20279.5 20818.0 20894.9 21212.2 993.4 997.0 1034.5 1035.1 1039.3 10149.5 11191.5 11398.0 11461.4 11488.3 511425.0 522594.0 527706.0 535678.0 559844.0 97190.0 100359.5 101479.0 103135.5 105716.5 992.8 1037.8 1045.2 1051.7 1066.0 17511.0 17866.6 18215.5 18350.1 18357.2 33261.8 38948.6 42518.8 44026.8 45168.3 55942.0 60134.4 61503.7 62043.0 62092.4 8087.3 8912.3 9027.5 9096.5 9138.3 13093.5 13168.7 13331.2 13515.9 13840.2 11597.5 11685.1 11835.7 11857.0 11922.4 10974.8 11200.4 11255.8 11712.3 11911.0 11609.7 11664.1 11793.6 11997.5 12191.6 9017.8 9146.7 9313.2 9372.1 9401.9 10526.3 11783.6 11853.6 11905.7 12023.8 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#3] mootools.html Cycles:180 Average:5958.56 Median:4387.97 stddev:3318.63 (75.6%) stddev-sans-first:3309.82 13:23:57 INFO - PROCESS | 20591 | Values: 1345.6 1521.3 1541.8 1723.7 1869.0 7595.0 8739.4 9004.9 9009.7 9330.6 9058.4 9118.1 9141.9 9142.6 9147.9 2482.5 2512.6 2513.0 2515.8 2517.0 2394.6 2472.0 2475.8 2476.5 2476.9 2438.8 2458.4 2458.5 2458.7 2460.2 2368.8 2388.7 2399.4 2402.7 2405.7 2380.8 2390.4 2392.3 2393.1 2395.8 8642.8 8809.2 8825.2 8829.8 8879.5 5233.9 5408.2 5410.8 5416.9 5426.2 3579.1 3594.8 3648.9 3667.5 3667.7 1285.1 1288.2 1294.3 1315.6 1324.9 12555.5 12625.6 12671.2 12684.9 12704.5 4716.7 4730.1 4761.3 4822.6 4944.2 9844.3 9908.9 10006.4 10010.2 10024.7 5503.6 5520.6 5521.4 5528.7 5529.6 4285.8 4407.7 4957.3 5065.8 5074.1 3938.1 3989.0 4051.8 4082.7 4087.8 1245.8 1262.4 1274.7 1275.4 1281.9 925.4 1024.2 1026.9 1029.5 1036.6 5943.1 6070.8 6071.2 6127.2 6253.3 998.9 1012.1 1013.5 1045.6 1048.5 4202.9 4340.2 4352.4 4368.3 4504.6 10644.7 10942.7 11033.5 11045.6 11046.6 10971.2 10972.2 10984.7 10997.4 11003.0 8105.1 8382.5 8399.1 8607.3 8607.5 6004.6 6069.1 6193.2 6325.9 6330.5 10198.2 10432.1 10560.5 10592.4 10650.4 10383.9 10445.8 10561.6 10605.1 10653.4 6844.2 7476.8 7902.2 7968.6 8092.6 8851.4 8927.2 8936.6 8940.2 8945.2 7649.9 7884.3 7945.1 8006.0 8006.0 7705.9 7706.8 7735.6 7823.3 7899.8 7188.2 7295.1 7295.2 7295.6 7300.9 5373.4 5498.1 5510.3 5523.1 5669.8 5533.8 5557.0 5697.6 5732.5 5914.3 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#4] prototype.html Cycles:180 Average:4794.26 Median:5490.31 stddev:1386.71 (25.3%) stddev-sans-first:1349.96 13:23:57 INFO - PROCESS | 20591 | Values: 353.9 359.2 360.7 361.6 369.0 5459.6 5498.7 5504.2 5521.4 5557.2 5454.7 5457.2 5466.6 5481.9 5503.2 4035.8 4141.3 4222.0 4243.0 4306.1 4274.2 4276.5 4283.4 4286.9 4294.5 4280.3 4283.0 4285.7 4288.1 4299.7 4030.8 4140.0 4204.1 4263.3 4264.5 3776.4 3787.7 3791.1 3794.5 3798.4 5291.7 5305.9 5305.9 5307.3 5314.2 4751.9 4853.8 4863.9 4866.2 4883.6 5654.9 5670.7 5671.0 5678.7 5689.7 4142.7 4143.5 4148.6 4160.8 4162.3 5786.8 5876.6 5892.4 5902.7 5914.3 4204.9 4215.6 4229.0 4231.0 4234.4 4257.2 4260.7 4265.4 4278.6 4292.5 4747.1 4793.2 4861.1 4866.7 4870.5 5715.2 5739.4 5745.7 5751.2 5774.9 1504.0 1514.8 1515.2 1517.8 1522.2 948.6 973.9 975.4 995.7 1003.6 5298.0 5349.3 5499.4 5505.5 5526.4 5807.4 5815.3 5818.7 5842.7 5843.0 5219.3 5368.2 5445.9 5450.7 5473.5 3049.5 3068.9 3069.6 3075.9 3095.2 5858.2 5973.5 6006.3 6016.3 6024.8 5876.2 5927.4 5966.7 5976.0 5992.3 5969.8 5979.0 5982.8 5983.3 6012.9 5560.0 5748.5 5790.4 5811.9 5853.7 5748.6 5752.7 5754.3 5759.5 5767.8 5804.5 5889.8 5915.2 5936.9 5969.3 4257.4 4315.5 4320.2 4345.2 4350.5 5745.6 5816.2 5817.5 5820.7 5820.7 5395.9 5638.2 5642.6 5651.5 5655.4 5576.6 5577.6 5601.4 5602.3 5635.4 5599.1 5606.8 5613.9 5623.5 5625.0 5345.4 5455.2 5578.7 5675.8 5692.7 5567.6 5581.7 5583.4 5591.1 5604.1 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - PROCESS | 20591 | [#5] yui.html Cycles:180 Average:22662.14 Median:4727.17 stddev:33424.35 (707.1%) stddev-sans-first:33477.91 13:23:57 INFO - PROCESS | 20591 | Values: 826.9 838.3 855.2 881.6 914.6 14757.3 15022.6 15173.0 15247.7 15395.2 14258.8 14429.1 14583.1 14587.4 14731.6 844.7 871.0 872.9 873.2 873.7 707.3 730.6 848.4 870.7 875.0 912.9 918.6 919.4 919.6 920.0 911.9 915.3 916.4 916.9 917.1 548.4 561.0 656.3 668.9 671.6 14819.9 14829.7 14850.3 14864.6 14910.4 15259.4 15757.6 15967.3 16260.8 16299.8 12909.3 12964.4 13037.3 13098.4 13330.9 4721.0 4740.5 4780.0 4806.5 4825.5 90266.0 90748.0 91460.0 93486.5 94903.0 12445.2 12556.9 12633.7 12722.9 12778.4 23986.0 24149.4 24244.4 24278.5 24378.6 8856.3 9014.8 9253.3 9425.5 9571.3 4783.6 5018.6 5068.4 5090.6 5247.1 3675.8 3785.7 3814.1 3814.8 3818.0 623.4 627.0 629.8 638.4 645.3 626.7 642.7 699.7 709.8 721.2 9901.8 9919.0 10045.8 10111.9 10444.9 645.6 662.2 710.7 748.4 750.4 4483.8 4538.5 4544.8 4733.4 4867.5 80383.0 81460.0 92975.0 134282.0 140146.0 111936.4 113405.0 117945.0 119761.0 119963.0 96753.0 97650.0 98967.0 101289.5 106374.0 9044.7 9226.4 9332.4 9373.9 9435.9 49926.5 59725.0 60438.7 61494.0 62086.0 81541.2 86708.0 86926.6 88276.0 91726.5 12867.4 12972.0 13154.4 13194.0 13341.4 14199.9 14267.4 14436.8 14532.0 14728.5 13128.5 13470.5 13873.7 13969.4 14424.6 13012.5 13175.4 13220.1 13627.4 13821.4 13348.1 13354.9 13457.2 13513.7 13809.0 11033.2 11344.7 11451.6 11471.4 11695.0 11239.6 11417.7 11504.7 11702.1 11746.9 13:23:57 INFO - PROCESS | 20591 | -------- Summary: end -------- 13:23:57 INFO - PROCESS | 20591 | 13:23:57 INFO - TEST-INFO | 20591: exit 0 13:23:57 INFO - TEST-OK | dromaeo_css | took 1114311ms 13:23:57 INFO - TEST-START | kraken 13:23:57 INFO - operating with platform_type : linux_ 13:23:57 INFO - Initialising browser for kraken test... 13:23:57 INFO - TEST-INFO | started process 20917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3im7uH/profile http://localhost:58057/getInfo.html) 13:24:02 INFO - PROCESS | 20917 | __metrics Screen width/height:1600/1200 13:24:02 INFO - PROCESS | 20917 | colorDepth:24 13:24:02 INFO - PROCESS | 20917 | Browser inner width/height: 1024/697 13:24:02 INFO - PROCESS | 20917 | __metrics 13:24:02 INFO - PROCESS | 20917 | 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" 13:24:02 INFO - PROCESS | 20917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:24:03 INFO - PROCESS | 20917 | console.error: PushService: 13:24:03 INFO - PROCESS | 20917 | stateChangeProcessEnqueue: Error transitioning state 13:24:03 INFO - PROCESS | 20917 | UnknownError 13:24:03 INFO - TEST-INFO | 20917: exit 0 13:24:03 INFO - Browser initialized. 13:24:03 INFO - Running cycle 1/1 for kraken test... 13:24:03 INFO - TEST-INFO | started process 21012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3im7uH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:15 INFO - PROCESS | 21012 | RSS: Main: 148340736 13:24:15 INFO - PROCESS | 21012 | 13:24:18 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58057/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:19 INFO - PROCESS | 21012 | RSS: Main: 190283776 13:24:19 INFO - PROCESS | 21012 | 13:24:21 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58057/tests/kraken/driver.html?testName=audio-dft) 13:24:22 INFO - PROCESS | 21012 | RSS: Main: 179073024 13:24:22 INFO - PROCESS | 21012 | 13:24:25 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58057/tests/kraken/driver.html?testName=audio-fft) 13:24:25 INFO - PROCESS | 21012 | RSS: Main: 270835712 13:24:25 INFO - PROCESS | 21012 | 13:24:27 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58057/tests/kraken/driver.html?testName=audio-oscillator) 13:24:28 INFO - PROCESS | 21012 | RSS: Main: 177045504 13:24:28 INFO - PROCESS | 21012 | 13:24:30 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:30 INFO - PROCESS | 21012 | RSS: Main: 178384896 13:24:30 INFO - PROCESS | 21012 | 13:24:33 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58057/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:34 INFO - PROCESS | 21012 | RSS: Main: 214302720 13:24:34 INFO - PROCESS | 21012 | 13:24:37 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58057/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:38 INFO - PROCESS | 21012 | RSS: Main: 212975616 13:24:38 INFO - PROCESS | 21012 | 13:24:41 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58057/tests/kraken/driver.html?testName=json-parse-financial) 13:24:41 INFO - PROCESS | 21012 | RSS: Main: 213049344 13:24:41 INFO - PROCESS | 21012 | 13:24:43 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:43 INFO - PROCESS | 21012 | RSS: Main: 175063040 13:24:43 INFO - PROCESS | 21012 | 13:24:45 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:46 INFO - PROCESS | 21012 | RSS: Main: 181972992 13:24:46 INFO - PROCESS | 21012 | 13:24:48 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:48 INFO - PROCESS | 21012 | RSS: Main: 189493248 13:24:48 INFO - PROCESS | 21012 | 13:24:51 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:51 INFO - PROCESS | 21012 | RSS: Main: 197636096 13:24:51 INFO - PROCESS | 21012 | 13:24:54 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:24:55 INFO - PROCESS | 21012 | RSS: Main: 194248704 13:24:55 INFO - PROCESS | 21012 | 13:24:56 INFO - PROCESS | 21012 | Cycle 1(1): loaded http://localhost:58057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58057/tests/kraken/driver.html?testName=ai-astar) 13:24:57 INFO - PROCESS | 21012 | RSS: Main: 245317632 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | __start_tp_report 13:24:57 INFO - PROCESS | 21012 | _x_x_mozilla_page_load 13:24:57 INFO - PROCESS | 21012 | _x_x_mozilla_page_load_details 13:24:57 INFO - PROCESS | 21012 | |i|pagename|runs| 13:24:57 INFO - PROCESS | 21012 | |0;ai-astar;108;109;110;109;109;109;110;110;108;110 13:24:57 INFO - PROCESS | 21012 | |1;audio-beat-detection;149;119;122;152;126;122;122;120;150;120 13:24:57 INFO - PROCESS | 21012 | |2;audio-dft;160;160;159;160;160;160;161;159;161;161 13:24:57 INFO - PROCESS | 21012 | |3;audio-fft;74;75;75;116;75;76;75;76;105;74 13:24:57 INFO - PROCESS | 21012 | |4;audio-oscillator;81;82;113;81;81;81;99;80;80;109 13:24:57 INFO - PROCESS | 21012 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;116;117;116 13:24:57 INFO - PROCESS | 21012 | |6;imaging-darkroom;147;145;146;146;146;145;146;146;146;145 13:24:57 INFO - PROCESS | 21012 | |7;imaging-desaturate;95;95;95;95;94;95;94;94;95;95 13:24:57 INFO - PROCESS | 21012 | |8;json-parse-financial;51;50;50;50;50;50;49;50;49;48 13:24:57 INFO - PROCESS | 21012 | |9;json-stringify-tinderbox;59;58;58;60;59;59;58;58;59;59 13:24:57 INFO - PROCESS | 21012 | |10;stanford-crypto-aes;79;83;73;81;73;73;73;72;73;74 13:24:57 INFO - PROCESS | 21012 | |11;stanford-crypto-ccm;121;122;122;122;132;128;122;119;153;159 13:24:57 INFO - PROCESS | 21012 | |12;stanford-crypto-pbkdf2;156;153;153;153;155;159;158;161;153;151 13:24:57 INFO - PROCESS | 21012 | |13;stanford-crypto-sha256-iterative;63;62;62;61;66;62;61;61;61;61 13:24:57 INFO - PROCESS | 21012 | __end_tp_report 13:24:57 INFO - PROCESS | 21012 | __start_cc_report 13:24:57 INFO - PROCESS | 21012 | _x_x_mozilla_cycle_collect,1553 13:24:57 INFO - PROCESS | 21012 | __end_cc_report 13:24:57 INFO - PROCESS | 21012 | __startTimestamp1477599897031__endTimestamp 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | ------- Summary: start ------- 13:24:57 INFO - PROCESS | 21012 | Number of tests: 14 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 13:24:57 INFO - PROCESS | 21012 | Values: 108.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 108.0 110.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:124.00 stddev:14.04 (11.3%) stddev-sans-first:13.14 13:24:57 INFO - PROCESS | 21012 | Values: 149.0 119.0 122.0 152.0 126.0 122.0 122.0 120.0 150.0 120.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:24:57 INFO - PROCESS | 21012 | Values: 160.0 160.0 159.0 160.0 160.0 160.0 161.0 159.0 161.0 161.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:15.21 (20.3%) stddev-sans-first:15.84 13:24:57 INFO - PROCESS | 21012 | Values: 74.0 75.0 75.0 116.0 75.0 76.0 75.0 76.0 105.0 74.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:81.00 stddev:13.09 (16.2%) stddev-sans-first:13.58 13:24:57 INFO - PROCESS | 21012 | Values: 81.0 82.0 113.0 81.0 81.0 81.0 99.0 80.0 80.0 109.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:24:57 INFO - PROCESS | 21012 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 13:24:57 INFO - PROCESS | 21012 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:24:57 INFO - PROCESS | 21012 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 13:24:57 INFO - PROCESS | 21012 | Values: 51.0 50.0 50.0 50.0 50.0 50.0 49.0 50.0 49.0 48.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 13:24:57 INFO - PROCESS | 21012 | Values: 59.0 58.0 58.0 60.0 59.0 59.0 58.0 58.0 59.0 59.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:73.50 stddev:4.01 (5.4%) stddev-sans-first:4.03 13:24:57 INFO - PROCESS | 21012 | Values: 79.0 83.0 73.0 81.0 73.0 73.0 73.0 72.0 73.0 74.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:125.00 stddev:14.28 (11.4%) stddev-sans-first:14.77 13:24:57 INFO - PROCESS | 21012 | Values: 121.0 122.0 122.0 122.0 132.0 128.0 122.0 119.0 153.0 159.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:3.22 (2.1%) stddev-sans-first:3.41 13:24:57 INFO - PROCESS | 21012 | Values: 156.0 153.0 153.0 153.0 155.0 159.0 158.0 161.0 153.0 151.0 13:24:57 INFO - PROCESS | 21012 | 13:24:57 INFO - PROCESS | 21012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.56 (2.5%) stddev-sans-first:1.62 13:24:57 INFO - PROCESS | 21012 | Values: 63.0 62.0 62.0 61.0 66.0 62.0 61.0 61.0 61.0 61.0 13:24:57 INFO - PROCESS | 21012 | -------- Summary: end -------- 13:24:57 INFO - PROCESS | 21012 | 13:24:58 INFO - TEST-INFO | 21012: exit 0 13:24:58 INFO - TEST-OK | kraken | took 60213ms 13:24:58 INFO - SUITE-END | took 1174s 13:24:58 INFO - Completed test suite (00:19:34) 13:24:58 INFO - javascript benchmark 13:24:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.6243250809903, 3174.0795169400863, 3178.5073313636385, 3189.4099591575546, 3221.09809253409, 5541.695206763627, 5598.748056337465, 5599.832005039855, 5631.127175287832, 5641.464060914217, 5591.077472217079, 5662.631928924617, 5662.943370566293, 5678.0, 5700.515456186229, 5123.743812809364, 5144.871378215537, 5179.922301165486, 5180.30468279225, 5227.32044834171, 5008.248762685608, 5029.798808047673, 5238.947610523884, 5239.580833533309, 5240.633155679085, 5049.24261360797, 5055.671381360218, 5082.974585127069, 5098.311727916739, 5149.639525233235, 5148.974255128719, 5165.3026841376495, 5252.606054545924, 5258.0535503609335, 5287.259783630295, 4838.080764654705, 5125.641205115643, 5152.149895267276, 5204.089284375219, 5216.217567364888, 5402.37872644647, 5468.371137319219, 5490.945090549123, 5508.55931525481, 5517.337919449652, 5895.204147440127, 5907.409259074101, 6000.699965001732, 6001.279846418414, 6010.038393856962, 5790.478856902899, 6041.0, 6050.818475445743, 6063.727132279058, 6075.908861367083, 5463.235147079412, 5503.669779813224, 5517.889642207174, 5560.499555040065, 5580.804671836466, 6133.754649814046, 6138.048602466625, 6141.539384546177, 6142.355052719489, 6147.877042459126, 5692.459216374438, 5906.734196961147, 5910.172575839386, 5911.438413350725, 5916.881662366729, 5800.709964501758, 5830.4461076197695, 5890.676012819336, 5893.057110862242, 5997.580169388189, 5907.409259074144, 5907.61600495975, 5908.615939963975, 5908.881822363614, 5918.8816223675285, 5854.0, 5900.439458251545, 5911.556633252523, 5919.822405327847, 5953.493953013955, 4482.103579284156, 4513.187626227311, 4532.954670453253, 4577.176108300471, 4578.198815207325, 4053.017091035938, 4081.89795255121, 4097.364908439196, 4102.261592913304, 4120.75275483472, 5596.2165296858475, 5611.130274807411, 5617.578681598897, 5620.606557540933, 5656.8868622627315, 5738.741756620962, 5797.826065218051, 5932.525397968152, 5955.464008239279, 5999.640021598718, 5680.68756218412, 5685.857853553694, 5697.373288938214, 5711.428857114339, 5729.140628905614, 5232.502912223333, 5246.658967167122, 5246.895062098737, 5247.895042099213, 5267.789288428497, 5919.852003699942, 6035.60768550034, 6105.145279660762, 6216.160818289563, 6233.501319894398, 5938.435848594377, 5938.584299099021, 6042.123892035543, 6072.119542666201, 6098.603590766586, 6068.302145253352, 6071.726772295346, 6072.453479186895, 6072.787452439144, 6073.99779036454, 5660.943390566042, 5827.475527202572, 5828.708564571839, 5831.212786273799, 5834.212381328466, 5873.442023007808, 5929.288485381781, 5949.167116603766, 5977.043673012297, 6066.514678825595, 5869.970650146722, 5870.26621672291, 5916.763329466773, 5917.082852157922, 5926.436988486087, 5818.24362832846, 5828.708564571839, 5845.0, 5849.473547380756, 5851.970740146272, 5550.722463876871, 5665.5750818689585, 5769.769209231752, 5814.069748840166, 5829.038208695518, 5953.523718102455, 5954.3152537458745, 5957.225560677258, 5961.2846458425265, 5962.19510366095, 5586.441355864381, 5634.859128521656, 5652.547796176378, 5792.652440853393, 5793.797217097382], "value": 5503.702416454661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7344531683402, 606.8045949479524, 623.7473823101644, 646.8027251688236, 647.7538535356564, 34290.31419371611, 37625.435618465744, 46770.29844552326, 47400.52599474004, 47454.7627261864, 49357.50642493574, 49927.50072499274, 49962.75018624902, 50021.74989125058, 50033.49966500334, 9366.34435589509, 9477.38397004196, 9485.146336829685, 9521.857172142423, 9530.046995300483, 8561.785955351135, 8756.56217189138, 11052.392118433483, 11299.49152288145, 11304.0, 11440.0, 11514.251573647727, 11535.711607209803, 11546.24949378292, 11549.6535103947, 11308.37803920784, 11359.488823002985, 11369.488373023192, 11375.431228438545, 11386.829197562043, 11260.436978151141, 11339.14956378275, 11344.262622929566, 11359.432028398629, 11363.772724545463, 46042.53957460416, 46268.305975410396, 46486.53513464856, 46527.0, 46645.0, 3826.885193444201, 3865.4008628662323, 3883.902902427462, 4057.3305404608204, 4155.2728272552185, 34471.31035511041, 34518.309633807185, 34543.4818477723, 34913.0, 34940.65059349425, 4486.461624605068, 4638.582527572501, 4656.092062047902, 4679.602233810097, 4687.7656117194, 365092.0, 367495.0, 368078.15960920294, 368408.9999999973, 368975.0, 65952.34047659558, 66104.33895661078, 66214.33785662179, 66294.66852665802, 66425.0, 41649.37525937113, 42249.36625950613, 42655.57344426578, 44448.0, 44515.55484445179, 19319.710204346946, 19496.317628883204, 19576.119074641676, 19608.0, 19699.11353989074, 13942.930285348508, 15024.624384390478, 15106.320215590325, 15121.848781512044, 15156.166410847289, 18614.720779188323, 20405.693914591295, 20927.47681307949, 20961.37115886526, 21682.34952951414, 7379.631018449056, 7437.665305061285, 7512.962435187789, 7587.241275872479, 7687.692492300357, 1128.497818470789, 1134.2117228526095, 1147.17976646698, 1191.666333426642, 1209.5826939705787, 35292.47061294083, 35454.08613122779, 35683.0, 35744.46383304252, 35764.82117589395, 1116.2855772305732, 1124.4040658451033, 1163.3834067943833, 1180.1620849196995, 1258.1633213912646, 18286.17712202954, 18351.908240458713, 18422.35521756732, 18511.35210267634, 18705.719414208797, 627192.0, 632291.0, 632399.0, 633050.0, 635996.0, 65151.67424162944, 65845.0, 65896.34103658998, 66011.0, 66044.66977665178, 1312.8687131286795, 1345.35422996962, 1367.3026756354132, 1378.2764048874421, 1394.4352537222442, 34724.82637586796, 35295.64704353026, 36266.456003159445, 36445.817770912035, 36729.44905826468, 63216.36783632105, 66695.0, 68451.0, 68652.656736716, 68666.0, 546274.0, 613332.0, 619683.0, 619843.0, 621970.0, 44911.55088449074, 48360.0, 48362.75818620884, 48448.5155148444, 49057.50942490529, 53200.2019969693, 53236.46763532315, 53607.731961339945, 54093.45906540884, 54575.0, 44296.92335336556, 44860.32709509425, 45324.773376134224, 46150.53849461462, 47798.0, 44886.0, 45146.77426612846, 45453.318200226364, 45872.08255834931, 46084.0, 44457.0, 44594.3310850344, 44801.10397792091, 44980.550194497635, 46485.767571163284, 38219.42670859884, 39549.0, 39986.40020399638, 40374.0, 41111.0, 30026.87599918807, 30038.849805750833, 30348.24129396783, 30582.541261881535, 30791.53812692856], "value": 22608.279149991875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.2253381312816, 398.4660554856492, 420.5941266677655, 426.53720713026365, 426.94449721536193, 14451.927740361296, 16383.590410239734, 20186.59626807463, 20906.68639970398, 21074.15703371867, 17963.281468741236, 18468.538286542844, 18737.718934215998, 20826.791732082675, 21009.0, 5743.798967036155, 5787.768489260425, 5891.88216235675, 5951.702414879261, 6012.669303188323, 4263.403123562688, 5831.30024397073, 5917.852053698649, 5922.1116832475045, 5924.58527903047, 4436.778161091948, 6222.377762223764, 6461.386168314003, 6522.902156467657, 6626.8674626507445, 6432.228132624092, 6597.274299827015, 6608.537402381835, 6613.900791488131, 6649.567778094409, 5896.941030589682, 5923.911141332884, 5925.8814823703715, 5926.111083337534, 5928.170056192136, 22773.772262277333, 23545.76454235453, 25328.0, 25372.619410708856, 25664.615030774552, 2432.902683892642, 2618.463215040912, 2642.2205449392477, 2973.613430254075, 3082.368114536537, 10500.159987201081, 10575.101116405114, 10661.680149595524, 13779.448822047207, 15201.771973420407, 1987.7714062882808, 2003.9539899353047, 2062.0308455026116, 2075.190675636503, 2086.3636590839787, 86961.13038869656, 89885.0, 91486.5425672874, 92187.0, 96446.0, 11515.136364772676, 11700.94149529264, 11712.355820429788, 11721.589744358907, 11763.823542646867, 16700.58248543796, 16801.91599041997, 16824.411145609844, 16840.24218910152, 16865.747013794804, 8695.565241732325, 9032.187103160748, 9036.81926361469, 9046.185843274137, 9098.272138228926, 8554.529500877512, 8724.476531408136, 8739.563021848882, 8780.770692103111, 8860.069692682304, 4998.750062496861, 5159.432462429129, 5167.534921856975, 5195.662281951737, 5239.1093514102695, 1991.4722598511405, 2085.9269925552535, 2112.6619740841393, 2132.6267903117205, 2164.1018977124318, 908.7001289574557, 980.9313348065567, 1020.4948550467418, 1021.9642312519026, 1022.8619136416637, 20016.799832001783, 20279.510856001998, 20818.0, 20894.895525522275, 21212.151513939578, 993.3791380387258, 997.0229175408141, 1034.5137785240925, 1035.0736091198335, 1039.2725092435326, 10149.492525373702, 11191.496382662799, 11398.0, 11461.426928653535, 11488.310701357945, 511425.0, 522594.0, 527706.0, 535678.0, 559844.0, 97190.0, 100359.49820250852, 101479.0, 103135.4843225779, 105716.47141764396, 992.8411454167299, 1037.8080055189814, 1045.163868904858, 1051.6844946516014, 1066.0352381095122, 17511.0, 17866.642667146843, 18215.544611384823, 18350.082495874885, 18357.173927173044, 33261.833690831394, 38948.6105138945, 42518.78740606277, 44026.77986610046, 45168.32247516356, 55942.042028528806, 60134.39865601288, 61503.692481537306, 62043.0, 62092.37907620866, 8087.3125784308995, 8912.28701703875, 9027.548622568976, 9096.54517274147, 9138.31462640318, 13093.476260949836, 13168.736625267633, 13331.200127991964, 13515.86484135146, 13840.23878686682, 11597.5360985563, 11685.123615728684, 11835.704107397383, 11857.0, 11922.4038798058, 10974.780504390028, 11200.439978000904, 11255.774884502427, 11712.297262164297, 11911.0, 11609.6517104487, 11664.125190610908, 11793.646190614296, 11997.520099195934, 12191.573294934635, 9017.774555635899, 9146.725598232064, 9313.208377287736, 9372.109649583279, 9401.905980940102, 10526.31578947366, 11783.587574434854, 11853.644390668294, 11905.702357441134, 12023.75952480963], "value": 9707.646147103538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.5626921250596, 1521.3382178752245, 1541.7533194688851, 1723.741438784183, 1868.9813101868976, 7594.962025189873, 8739.431936924095, 9004.8649270261, 9009.684661036865, 9330.626774928995, 9058.365914385995, 9118.133777291163, 9141.862872056925, 9142.588583513758, 9147.908520914789, 2482.5159093976636, 2512.623106534016, 2512.994802079174, 2515.76100270474, 2516.9748302517014, 2394.6048901931163, 2472.0, 2475.752424757519, 2476.5046990601863, 2476.8513889166707, 2438.8048956083558, 2458.409981604411, 2458.545169143705, 2458.7172475165316, 2460.1758410932357, 2368.834181607288, 2388.7014123234594, 2399.436132508859, 2402.6636270922086, 2405.7113146422366, 2380.845245059083, 2390.438247011951, 2392.2823153054187, 2393.066703985447, 2395.8083353331867, 8642.827143457096, 8809.163129502687, 8825.161609647073, 8829.779255518599, 8879.51162686052, 5233.921491177635, 5408.215808707715, 5410.83767486976, 5416.91874621881, 5426.158945363475, 3579.1052236940764, 3594.7843129412317, 3648.908777280563, 3667.468217108504, 3667.7065834733157, 1285.1325355385077, 1288.22062652096, 1294.3140135728079, 1315.6316231455112, 1324.8675132486674, 12555.497780088786, 12625.621231362982, 12671.239725616493, 12684.936575317157, 12704.475462944414, 4716.693414928019, 4730.148573256847, 4761.316526749058, 4822.590079843252, 4944.159492886218, 9844.261680374, 9908.851367229498, 10006.44964526958, 10010.249231307535, 10024.699259022242, 5503.6147469677535, 5520.613557051048, 5521.4478552145265, 5528.668279903219, 5529.612927095145, 4285.7642829644665, 4407.669424793154, 4957.3307603473795, 5065.772040258197, 5074.08666440037, 3938.074552480165, 3989.0226894410475, 4051.777152256654, 4082.693797965105, 4087.754734715867, 1245.8442694663167, 1262.4066688656317, 1274.7386785708907, 1275.43880692495, 1281.8782215689494, 925.4493576322078, 1024.2369434771142, 1026.9024442677933, 1029.5006921642996, 1036.5853658536646, 5943.108533719977, 6070.848228794315, 6071.241094863142, 6127.234095738033, 6253.312135665074, 998.8501724741346, 1012.1245122968726, 1013.533774463755, 1045.5869931377063, 1048.5229220704562, 4202.873913782591, 4340.153670034376, 4352.412424322676, 4368.27923392643, 4504.61710754583, 10644.733881652866, 10942.726431839108, 11033.503492342703, 11045.558177672963, 11046.558137674403, 10971.177161712903, 10972.177086718368, 10984.670459886216, 10997.395143267036, 11003.0, 8105.1489593593005, 8382.49705017701, 8399.076101628816, 8607.311415086904, 8607.526586037702, 6004.639721616542, 6069.119977603311, 6193.163922870535, 6325.873482530232, 6330.52521060913, 10198.18414526851, 10432.113270372103, 10560.471976400995, 10592.364458132537, 10650.414227217578, 10383.94808025955, 10445.843312350473, 10561.63034293796, 10605.098566621615, 10653.414062226342, 6844.178698556205, 7476.813079672834, 7902.170272121574, 7968.641411136628, 8092.595370231583, 8851.424657397249, 8927.196552310323, 8936.597853096757, 8940.195382415613, 8945.23965462917, 7649.923500765144, 7884.29041386278, 7945.0863150738405, 8006.0, 8006.039275287003, 7705.922940770521, 7706.7687969361, 7735.613219338898, 7823.2567906048835, 7899.763007109796, 7188.209296977224, 7295.051643286339, 7295.161056478573, 7295.598742069024, 7300.853982920205, 5373.382061063028, 5498.092814685532, 5510.311211098613, 5523.116301391758, 5669.773209071591, 5533.806316778893, 5557.0, 5697.6296540724725, 5732.541396688338, 5914.34942156371], "value": 4811.157298133708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8637624514562, 359.2312451354102, 360.6591770776617, 361.56973201889747, 368.9760165589235, 5459.5905307101975, 5498.725063746807, 5504.17437384392, 5521.365043020054, 5557.194206840006, 5454.672719636825, 5457.208704737811, 5466.562674986001, 5481.890362192754, 5503.229547863302, 4035.7982100894983, 4141.337386018237, 4221.957780422203, 4242.97878510607, 4306.138772245547, 4274.187904298189, 4276.524599013335, 4283.357496375537, 4286.914261714764, 4294.463192100988, 4280.293751530994, 4283.01490657149, 4285.700000999916, 4288.1423715256915, 4299.731579184133, 4030.7581545107387, 4139.958600413987, 4204.138151678899, 4263.275243208662, 4264.488261408651, 3776.433534969749, 3787.696984241254, 3791.109089363997, 3794.5256842894637, 3798.442638518194, 5291.656042357273, 5305.893882122375, 5305.920411193797, 5307.310049693554, 5314.202869569557, 4751.881202969919, 4853.805847766085, 4863.8784030399165, 4866.245731911559, 4883.633727470454, 5654.943450565483, 5670.68811215383, 5671.0, 5678.659280443146, 5689.715514224314, 4142.730722503027, 4143.482064741907, 4148.647364973951, 4160.750354978711, 4162.334026555767, 5786.826395208151, 5876.61801982874, 5892.381299963485, 5902.734376953047, 5914.319853216849, 4204.873853784391, 4215.557366476537, 4228.985043589516, 4231.0, 4234.407182994383, 4257.212415703105, 4260.68044896634, 4265.3815196796295, 4278.63631591312, 4292.506361768436, 4747.074320507468, 4793.158909501429, 4861.1006963711825, 4866.732329721828, 4870.537298956593, 5715.228444160069, 5739.368669446358, 5745.712714364265, 5751.166080918243, 5774.942250577525, 1503.9774403383958, 1514.8485151484763, 1515.1969456188237, 1517.8026856508584, 1522.2464879884308, 948.6015873333216, 973.868527748759, 975.4244995452717, 995.6913356859396, 1003.5584342889106, 5298.0, 5349.304590403222, 5499.367572729107, 5505.513511351993, 5526.364468086141, 5807.361190269067, 5815.3021637402935, 5818.738156782955, 5842.737076831553, 5842.970785146047, 5219.269302297681, 5368.1679339702405, 5445.863853403617, 5450.672959622356, 5473.452654734574, 3049.4968330225706, 3068.8951977288157, 3069.6009518762417, 3075.938481230363, 3095.1797773590015, 5858.179854820329, 5973.522118230618, 6006.279246490361, 6016.338202797689, 6024.819255422344, 5876.236089308362, 5927.436893495111, 5966.701664916824, 5975.970120149372, 5992.280926288786, 5969.776195879835, 5978.970105149447, 5982.820515384546, 5983.341832398432, 6012.9098063529955, 5559.972200138974, 5748.45389687979, 5790.363060063474, 5811.854703632443, 5853.736581853912, 5748.626339287933, 5752.734398432338, 5754.338251101177, 5759.452851979056, 5767.798127065533, 5804.477597016289, 5889.823305300848, 5915.171875937286, 5936.940630593639, 5969.313528944227, 4257.382679511392, 4315.482142142963, 4320.200762858881, 4345.152695224401, 4350.499692535399, 5745.621050947826, 5816.214811000461, 5817.5345972321265, 5820.679862607428, 5820.73806678692, 5395.8775851739565, 5638.21065050885, 5642.633228840113, 5651.491365777099, 5655.388214358888, 5576.553875689854, 5577.609567330248, 5601.383847776659, 5602.327720673546, 5635.351934527418, 5599.1041433370465, 5606.831795046155, 5613.915791263216, 5623.509769911058, 5625.046850403571, 5345.358556973188, 5455.236266922555, 5578.748956297058, 5675.764814056113, 5692.743826527899, 5567.638103523258, 5581.734685209198, 5583.385827558884, 5591.10542313228, 5604.103343465026], "value": 4359.406097476852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.9415148609778, 838.3125836813813, 855.1533981358457, 881.5548148185165, 914.6432891172448, 14757.335919883604, 15022.624434389145, 15173.0, 15247.695046099072, 15395.153266570349, 14258.786118208236, 14429.062110962781, 14583.125012499231, 14587.41650333988, 14731.631709207275, 844.7043534762814, 870.9695160669378, 872.8690696395528, 873.2271939333704, 873.6942070275385, 707.345705222667, 730.6127752291268, 848.3891598049395, 870.6734974384606, 874.9737507874742, 912.8721978922923, 918.6279556779515, 919.3886065766258, 919.5815903763771, 919.9770005749842, 911.9316051296146, 915.3409545127497, 916.3631276263, 916.903725108864, 917.1104029091771, 548.4214154067457, 561.0462214235815, 656.3469347998724, 668.8595394967014, 671.6473851228095, 14819.851801481955, 14829.703405931821, 14850.331735071839, 14864.554063378117, 14910.403583856632, 15259.389624415011, 15757.60605984848, 15967.281472333656, 16260.75608865868, 16299.755503667455, 12909.289989050598, 12964.351782410937, 13037.282949437777, 13098.410571524304, 13330.86669133306, 4720.976395118037, 4740.502247264022, 4779.952200477986, 4806.543378379049, 4825.541573550507, 90266.0, 90748.0, 91460.0, 93486.5325673374, 94903.0, 12445.191062580903, 12556.874431255754, 12633.684157896127, 12722.860538827368, 12778.424970876333, 23986.0, 24149.396265093514, 24244.39389015289, 24278.514429711307, 24378.634320485206, 8856.291496680251, 9014.819703606023, 9253.306002049738, 9425.528723563932, 9571.28215383849, 4783.617310615143, 5018.5985121190215, 5068.41713202979, 5090.618203634742, 5247.10799164143, 3675.7794532328144, 3785.734998550075, 3814.1418180909627, 3814.828332725034, 3817.9809100954317, 623.3921926122085, 626.9529785266124, 629.7606909374408, 638.4254171245916, 645.2643985856128, 626.7242413338208, 642.6947200079925, 699.6886385558479, 709.7515869445756, 721.2030706069822, 9901.801963960825, 9918.950405248072, 10045.849312260321, 10111.949440252753, 10444.947775261075, 645.6287634610118, 662.1663147669051, 710.6852323202035, 748.4424104042523, 750.3996802557932, 4483.7533935633855, 4538.546145385501, 4544.840930567414, 4733.36099626546, 4867.464578896319, 80383.0, 81460.0, 92975.0, 134282.0, 140146.0, 111936.44031779951, 113405.0, 117945.0, 119761.0, 119963.0, 96753.0324696758, 97650.0, 98967.0, 101289.49355253177, 106374.0, 9044.683436079706, 9226.446413215228, 9332.440053596805, 9373.906260937576, 9435.905640943503, 49926.500734993635, 59725.0, 60438.69780651069, 61494.0, 62086.0, 81541.18458815335, 86708.0, 86926.5653671753, 88276.0, 91726.54136729274, 12867.420966056738, 12972.0, 13154.408051637507, 13194.0, 13341.399637016551, 14199.858001419854, 14267.42930282777, 14436.783448248494, 14532.0, 14728.484503042342, 13128.474861005834, 13470.52853150135, 13873.722525549634, 13969.371378288204, 14424.567262982127, 13012.544560940321, 13175.407106680032, 13220.074594778273, 13627.38676759568, 13821.378037988114, 13348.065635405817, 13354.866451335361, 13457.192568445924, 13513.662158446117, 13809.0, 11033.227674062739, 11344.659660210207, 11451.625804903464, 11471.369074700971, 11695.0, 11239.55041798319, 11417.657470275904, 11504.680630464394, 11702.122340824302, 11746.882531174579], "value": 7952.293631144457, "unit": "score"}], "name": "dromaeo_css", "value": 7656.708565295324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 108.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 122.0, 152.0, 126.0, 122.0, 122.0, 120.0, 150.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0, 159.0, 161.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 116.0, 75.0, 76.0, 75.0, 76.0, 105.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 113.0, 81.0, 81.0, 81.0, 99.0, 80.0, 80.0, 109.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 50.0, 49.0, 48.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 60.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 73.0, 81.0, 73.0, 73.0, 73.0, 72.0, 73.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 122.0, 122.0, 132.0, 128.0, 122.0, 119.0, 153.0, 159.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 153.0, 153.0, 155.0, 159.0, 158.0, 161.0, 153.0, 151.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 66.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1458.7000000000003, "alertThreshold": 2.0}]} 13:24:58 INFO - Return code: 0 13:24:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:24:58 INFO - # TBPL SUCCESS # 13:24:58 INFO - Running post-action listener: _resource_record_post_action 13:24:58 INFO - [mozharness: 2016-10-27 20:24:58.312972Z] Finished run-tests step (success) 13:24:58 INFO - Running post-run listener: _resource_record_post_run 13:24:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358838272; Read time: 16; Write time: 284752 13:24:58 INFO - TinderboxPrint: CPU usage
12.9% 13:24:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:24:58 INFO - TinderboxPrint: I/O write bytes / time
358,838,272 / 284,752 13:24:58 INFO - TinderboxPrint: CPU idle
8,274.8 (87.0%) 13:24:58 INFO - TinderboxPrint: CPU user
1,184.7 (12.5%) 13:24:58 INFO - TinderboxPrint: Swap in / out
0 / 0 13:24:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111255552; Read time: 0; Write time: 102980 13:24:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 247582720; Read time: 0; Write time: 181772 13:24:58 INFO - Running post-run listener: _upload_blobber_files 13:24:58 INFO - Blob upload gear active. 13:24:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:24:58 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 13:24:58 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'] 13:24:58 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 13:24:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:24:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:24:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:03 INFO - (blobuploader) - INFO - Done attempting. 13:25:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:25:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:25:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:04 INFO - (blobuploader) - INFO - Done attempting. 13:25:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:25:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:25:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:04 INFO - (blobuploader) - INFO - Done attempting. 13:25:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:25:04 INFO - Return code: 0 13:25:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:25:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:25:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ca13b6cb377a6086632afff041db25e5e1070daedd71adfc375864ea8191e8ef53f0951fccb09ecebf8303c58e934d306653854b45c50e28064b9bdaef61e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2214639b89ed9f54364df512ce2f3569808ce102c4f6a568ef615d5e782d07635be172cda5bf7be2bac9b4a14314b32ac72e61d6d60998a3c975c741a6fb4aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1900ee04f3541cfd007b479c7095b00443624919083340922cf2d925221a04f687e4925aa2226b884d782bc0a639007fedb054c6979381a9f56855d10da6daa5"} 13:25:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:25:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:25:04 INFO - Contents: 13:25:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ca13b6cb377a6086632afff041db25e5e1070daedd71adfc375864ea8191e8ef53f0951fccb09ecebf8303c58e934d306653854b45c50e28064b9bdaef61e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2214639b89ed9f54364df512ce2f3569808ce102c4f6a568ef615d5e782d07635be172cda5bf7be2bac9b4a14314b32ac72e61d6d60998a3c975c741a6fb4aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1900ee04f3541cfd007b479c7095b00443624919083340922cf2d925221a04f687e4925aa2226b884d782bc0a639007fedb054c6979381a9f56855d10da6daa5"} 13:25:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:25:04 INFO - Copying logs to upload dir... 13:25:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:25:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.900879 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-27 13:25:04.810364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 13:25:04.813913) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 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/9ca13b6cb377a6086632afff041db25e5e1070daedd71adfc375864ea8191e8ef53f0951fccb09ecebf8303c58e934d306653854b45c50e28064b9bdaef61e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2214639b89ed9f54364df512ce2f3569808ce102c4f6a568ef615d5e782d07635be172cda5bf7be2bac9b4a14314b32ac72e61d6d60998a3c975c741a6fb4aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1900ee04f3541cfd007b479c7095b00443624919083340922cf2d925221a04f687e4925aa2226b884d782bc0a639007fedb054c6979381a9f56855d10da6daa5"} build_url:https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/RRwoSpG9SPK5BV8GUNcF5w/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/9ca13b6cb377a6086632afff041db25e5e1070daedd71adfc375864ea8191e8ef53f0951fccb09ecebf8303c58e934d306653854b45c50e28064b9bdaef61e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2214639b89ed9f54364df512ce2f3569808ce102c4f6a568ef615d5e782d07635be172cda5bf7be2bac9b4a14314b32ac72e61d6d60998a3c975c741a6fb4aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1900ee04f3541cfd007b479c7095b00443624919083340922cf2d925221a04f687e4925aa2226b884d782bc0a639007fedb054c6979381a9f56855d10da6daa5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 13:25:04.839414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:25:04.839750) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477598669.49383-752088973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:25:04.923303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 13:25:04.923626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 13:25:04.923907) ========= ========= Total master_lag: 0.18 =========