builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1477362247.16 results: success (0) buildid: 20161024163422 builduid: ffd332a51cc145c4b3042b07ea82fa72 revision: fcd7ad8a2488527ce094cbdb3582c29437c155a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.160128) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.160622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.160899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.175097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.175508) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 19:24:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-10-24 19:24:07 (50.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.286199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.289643) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.339282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:07.342771) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcd7ad8a2488527ce094cbdb3582c29437c155a8 --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 fcd7ad8a2488527ce094cbdb3582c29437c155a8 --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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 19:24:07,567 truncating revision to first 12 chars 2016-10-24 19:24:07,568 Setting DEBUG logging. 2016-10-24 19:24:07,568 attempt 1/10 2016-10-24 19:24:07,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fcd7ad8a2488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 19:24:07,880 unpacking tar archive at: mozilla-aurora-fcd7ad8a2488/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:08.002295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:08.003577) ========= script_repo_revision: fcd7ad8a2488527ce094cbdb3582c29437c155a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:08.004009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:08.004284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 19:24:08.014589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-24 19:24:08.015006) ========= /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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:24:08 INFO - MultiFileLogger online at 20161024 19:24:08 in /builds/slave/test 19:24:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:24:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:08 INFO - {'append_to_log': False, 19:24:08 INFO - 'base_work_dir': '/builds/slave/test', 19:24:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:24:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:08 INFO - 'branch': 'Mozilla-Aurora', 19:24:08 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:08 INFO - 'config_files': ('talos/linux_config.py',), 19:24:08 INFO - 'default_actions': ('clobber', 19:24:08 INFO - 'read-buildbot-config', 19:24:08 INFO - 'download-and-extract', 19:24:08 INFO - 'populate-webroot', 19:24:08 INFO - 'create-virtualenv', 19:24:08 INFO - 'install', 19:24:08 INFO - 'run-tests'), 19:24:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:08 INFO - 'download_minidump_stackwalk': True, 19:24:08 INFO - 'download_symbols': 'ondemand', 19:24:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:08 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:08 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:08 INFO - 'installer_path': 'installer.exe', 19:24:08 INFO - 'log_level': 'info', 19:24:08 INFO - 'log_name': 'talos', 19:24:08 INFO - 'log_to_console': True, 19:24:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:24:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:24:08 INFO - 'opt_config_files': (), 19:24:08 INFO - 'pip_index': False, 19:24:08 INFO - 'sps_profile': False, 19:24:08 INFO - 'sps_profile_interval': 0, 19:24:08 INFO - 'suite': 'dromaeojs', 19:24:08 INFO - 'system_bits': '32', 19:24:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:08 INFO - 'title': 'talos-linux64-ix-046', 19:24:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:08 INFO - 'use_talos_json': True, 19:24:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:08 INFO - 'work_dir': 'build'} 19:24:08 INFO - [mozharness: 2016-10-25 02:24:08.338370Z] Running clobber step. 19:24:08 INFO - Running pre-action listener: _resource_record_pre_action 19:24:08 INFO - Running main action method: clobber 19:24:08 INFO - rmtree: /builds/slave/test/build 19:24:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:08 INFO - Running post-action listener: _resource_record_post_action 19:24:08 INFO - [mozharness: 2016-10-25 02:24:08.800003Z] Finished clobber step (success) 19:24:08 INFO - [mozharness: 2016-10-25 02:24:08.800104Z] Running read-buildbot-config step. 19:24:08 INFO - Running pre-action listener: _resource_record_pre_action 19:24:08 INFO - Running main action method: read_buildbot_config 19:24:08 INFO - Using buildbot properties: 19:24:08 INFO - { 19:24:08 INFO - "project": "", 19:24:08 INFO - "product": "firefox", 19:24:08 INFO - "script_repo_revision": "production", 19:24:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:24:08 INFO - "repository": "", 19:24:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:24:08 INFO - "buildid": "20161024163422", 19:24:08 INFO - "pgo_build": "True", 19:24:08 INFO - "basedir": "/builds/slave/test", 19:24:08 INFO - "buildnumber": 588, 19:24:08 INFO - "slavename": "talos-linux64-ix-046", 19:24:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:24:08 INFO - "platform": "ubuntu64_hw", 19:24:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:24:08 INFO - "branch": "mozilla-aurora", 19:24:08 INFO - "repo_path": "releases/mozilla-aurora", 19:24:08 INFO - "revision": "fcd7ad8a2488527ce094cbdb3582c29437c155a8", 19:24:08 INFO - "stage_platform": "linux64-pgo", 19:24:08 INFO - "builduid": "ffd332a51cc145c4b3042b07ea82fa72", 19:24:08 INFO - "slavebuilddir": "test" 19:24:08 INFO - } 19:24:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 19:24:08 INFO - Running post-action listener: _resource_record_post_action 19:24:08 INFO - [mozharness: 2016-10-25 02:24:08.802571Z] Finished read-buildbot-config step (success) 19:24:08 INFO - [mozharness: 2016-10-25 02:24:08.802661Z] Running download-and-extract step. 19:24:08 INFO - Running pre-action listener: _resource_record_pre_action 19:24:08 INFO - Running main action method: download_and_extract 19:24:08 INFO - mkdir: /builds/slave/test/build/tests 19:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:08 INFO - trying https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:24:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:24:09 INFO - Downloaded 1361 bytes. 19:24:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:24:09 INFO - Using the following test package requirements: 19:24:09 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:24:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:24:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:24:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'jsshell-linux-x86_64.zip'], 19:24:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:24:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:24:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:24:09 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:24:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:24:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:24:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:24:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:24:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:24:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:24:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:24:09 INFO - Expected file size: 21910083 19:24:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:24:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:24:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:24:14 INFO - Fetch https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:24:14 INFO - Expected file size: 21910083 19:24:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 19:24:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:24:19 INFO - Fetch https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 19:24:20 INFO - Expected file size: 14414081 19:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:20 INFO - trying https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:24:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:24:21 INFO - Downloaded 63998254 bytes. 19:24:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:24:21 INFO - mkdir: /builds/slave/test/properties 19:24:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:21 INFO - Contents: 19:24:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:24:22 INFO - Running post-action listener: _resource_record_post_action 19:24:22 INFO - Running post-action listener: set_extra_try_arguments 19:24:22 INFO - [mozharness: 2016-10-25 02:24:22.330812Z] Finished download-and-extract step (success) 19:24:22 INFO - [mozharness: 2016-10-25 02:24:22.331042Z] Running populate-webroot step. 19:24:22 INFO - Running pre-action listener: _resource_record_pre_action 19:24:22 INFO - Running main action method: populate_webroot 19:24:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:22 INFO - '--tppagecycles', 19:24:22 INFO - '7'], 19:24:22 INFO - 'tests': ['tsvgm']}}, 19:24:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['damp', 'tps']}, 19:24:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'tests': ['damp', 'tps']}, 19:24:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['dromaeo_dom']}, 19:24:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['basic_compositor_video']}, 19:24:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:24:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['a11yr', 19:24:22 INFO - 'ts_paint', 19:24:22 INFO - 'tpaint', 19:24:22 INFO - 'sessionrestore', 19:24:22 INFO - 'sessionrestore_no_auto_restore', 19:24:22 INFO - 'tabpaint']}, 19:24:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['tsvgx', 19:24:22 INFO - 'tsvgr_opacity', 19:24:22 INFO - 'tart', 19:24:22 INFO - 'tscrollx', 19:24:22 INFO - 'cart']}, 19:24:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:22 INFO - 'tsvgr_opacity', 19:24:22 INFO - 'tart', 19:24:22 INFO - 'tscrollx', 19:24:22 INFO - 'cart']}, 19:24:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'talos_options': ['--disable-e10s'], 19:24:22 INFO - 'tests': ['tp5o']}, 19:24:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'tests': ['tp5o']}, 19:24:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'talos_options': ['--disable-e10s', 19:24:22 INFO - '--xperf_path', 19:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:22 INFO - 'tests': ['tp5n']}, 19:24:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:22 INFO - 'talos_options': ['--xperf_path', 19:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:22 INFO - 'tests': ['tp5n']}}, 19:24:22 INFO - 'talos.zip': {'path': '', 19:24:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:22 INFO - Running post-action listener: _resource_record_post_action 19:24:22 INFO - [mozharness: 2016-10-25 02:24:22.350830Z] Finished populate-webroot step (success) 19:24:22 INFO - [mozharness: 2016-10-25 02:24:22.350919Z] Running create-virtualenv step. 19:24:22 INFO - Running pre-action listener: _resource_record_pre_action 19:24:22 INFO - Running main action method: create_virtualenv 19:24:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:24:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:22 INFO - Using real prefix '/usr' 19:24:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:24 INFO - Installing pip.................done. 19:24:24 INFO - Return code: 0 19:24:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:24 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:24:24 INFO - Using env: {'DISPLAY': ':0', 19:24:24 INFO - 'HOME': '/home/cltbld', 19:24:24 INFO - 'LANG': 'en_US.UTF-8', 19:24:24 INFO - 'LANGUAGE': 'en_US:en', 19:24:24 INFO - 'LOGNAME': 'cltbld', 19:24:24 INFO - 'MAIL': '/var/mail/cltbld', 19:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:24 INFO - 'MOZ_NO_REMOTE': '1', 19:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:24 INFO - 'NO_EM_RESTART': '1', 19:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:24 INFO - 'PWD': '/builds/slave/test', 19:24:24 INFO - 'SHELL': '/bin/bash', 19:24:24 INFO - 'SHLVL': '1', 19:24:24 INFO - 'TERM': 'linux', 19:24:24 INFO - 'TMOUT': '86400', 19:24:24 INFO - 'USER': 'cltbld', 19:24:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:24 INFO - '_': '/tools/buildbot/bin/python'} 19:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:24:25 INFO - Cleaning up... 19:24:25 INFO - Return code: 0 19:24:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:24:25 INFO - Using env: {'DISPLAY': ':0', 19:24:25 INFO - 'HOME': '/home/cltbld', 19:24:25 INFO - 'LANG': 'en_US.UTF-8', 19:24:25 INFO - 'LANGUAGE': 'en_US:en', 19:24:25 INFO - 'LOGNAME': 'cltbld', 19:24:25 INFO - 'MAIL': '/var/mail/cltbld', 19:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:25 INFO - 'MOZ_NO_REMOTE': '1', 19:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:25 INFO - 'NO_EM_RESTART': '1', 19:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:25 INFO - 'PWD': '/builds/slave/test', 19:24:25 INFO - 'SHELL': '/bin/bash', 19:24:25 INFO - 'SHLVL': '1', 19:24:25 INFO - 'TERM': 'linux', 19:24:25 INFO - 'TMOUT': '86400', 19:24:25 INFO - 'USER': 'cltbld', 19:24:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:25 INFO - '_': '/tools/buildbot/bin/python'} 19:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:25 INFO - Downloading/unpacking psutil>=3.1.1 19:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:27 INFO - Installing collected packages: psutil 19:24:27 INFO - Running setup.py install for psutil 19:24:27 INFO - building 'psutil._psutil_linux' extension 19:24:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:24:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:24:27 INFO - building 'psutil._psutil_posix' extension 19:24:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:24:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:24:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:27 INFO - Successfully installed psutil 19:24:27 INFO - Cleaning up... 19:24:27 INFO - Return code: 0 19:24:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:27 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:24:27 INFO - Using env: {'DISPLAY': ':0', 19:24:27 INFO - 'HOME': '/home/cltbld', 19:24:27 INFO - 'LANG': 'en_US.UTF-8', 19:24:27 INFO - 'LANGUAGE': 'en_US:en', 19:24:27 INFO - 'LOGNAME': 'cltbld', 19:24:27 INFO - 'MAIL': '/var/mail/cltbld', 19:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:27 INFO - 'MOZ_NO_REMOTE': '1', 19:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:27 INFO - 'NO_EM_RESTART': '1', 19:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:27 INFO - 'PWD': '/builds/slave/test', 19:24:27 INFO - 'SHELL': '/bin/bash', 19:24:27 INFO - 'SHLVL': '1', 19:24:27 INFO - 'TERM': 'linux', 19:24:27 INFO - 'TMOUT': '86400', 19:24:27 INFO - 'USER': 'cltbld', 19:24:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:27 INFO - '_': '/tools/buildbot/bin/python'} 19:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:30 INFO - Installing collected packages: mozsystemmonitor 19:24:30 INFO - Running setup.py install for mozsystemmonitor 19:24:30 INFO - Successfully installed mozsystemmonitor 19:24:30 INFO - Cleaning up... 19:24:30 INFO - Return code: 0 19:24:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:30 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:24:30 INFO - Using env: {'DISPLAY': ':0', 19:24:30 INFO - 'HOME': '/home/cltbld', 19:24:30 INFO - 'LANG': 'en_US.UTF-8', 19:24:30 INFO - 'LANGUAGE': 'en_US:en', 19:24:30 INFO - 'LOGNAME': 'cltbld', 19:24:30 INFO - 'MAIL': '/var/mail/cltbld', 19:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:30 INFO - 'MOZ_NO_REMOTE': '1', 19:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:30 INFO - 'NO_EM_RESTART': '1', 19:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:30 INFO - 'PWD': '/builds/slave/test', 19:24:30 INFO - 'SHELL': '/bin/bash', 19:24:30 INFO - 'SHLVL': '1', 19:24:30 INFO - 'TERM': 'linux', 19:24:30 INFO - 'TMOUT': '86400', 19:24:30 INFO - 'USER': 'cltbld', 19:24:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:30 INFO - '_': '/tools/buildbot/bin/python'} 19:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:32 INFO - warning: no files found matching '*.txt' 19:24:32 INFO - no previously-included directories found matching 'build' 19:24:32 INFO - no previously-included directories found matching 'dist' 19:24:32 INFO - no previously-included directories found matching '.git*' 19:24:32 INFO - Installing collected packages: jsonschema, functools32 19:24:32 INFO - Running setup.py install for functools32 19:24:32 INFO - warning: no files found matching '*.txt' 19:24:32 INFO - no previously-included directories found matching 'build' 19:24:32 INFO - no previously-included directories found matching 'dist' 19:24:32 INFO - no previously-included directories found matching '.git*' 19:24:32 INFO - Successfully installed jsonschema functools32 19:24:32 INFO - Cleaning up... 19:24:32 INFO - Return code: 0 19:24:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:24:32 INFO - Using env: {'DISPLAY': ':0', 19:24:32 INFO - 'HOME': '/home/cltbld', 19:24:32 INFO - 'LANG': 'en_US.UTF-8', 19:24:32 INFO - 'LANGUAGE': 'en_US:en', 19:24:32 INFO - 'LOGNAME': 'cltbld', 19:24:32 INFO - 'MAIL': '/var/mail/cltbld', 19:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:32 INFO - 'MOZ_NO_REMOTE': '1', 19:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:32 INFO - 'NO_EM_RESTART': '1', 19:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:32 INFO - 'PWD': '/builds/slave/test', 19:24:32 INFO - 'SHELL': '/bin/bash', 19:24:32 INFO - 'SHLVL': '1', 19:24:32 INFO - 'TERM': 'linux', 19:24:32 INFO - 'TMOUT': '86400', 19:24:32 INFO - 'USER': 'cltbld', 19:24:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:32 INFO - '_': '/tools/buildbot/bin/python'} 19:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:33 INFO - Cleaning up... 19:24:33 INFO - Return code: 0 19:24:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:33 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:24:33 INFO - Using env: {'DISPLAY': ':0', 19:24:33 INFO - 'HOME': '/home/cltbld', 19:24:33 INFO - 'LANG': 'en_US.UTF-8', 19:24:33 INFO - 'LANGUAGE': 'en_US:en', 19:24:33 INFO - 'LOGNAME': 'cltbld', 19:24:33 INFO - 'MAIL': '/var/mail/cltbld', 19:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:33 INFO - 'MOZ_NO_REMOTE': '1', 19:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:33 INFO - 'NO_EM_RESTART': '1', 19:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:33 INFO - 'PWD': '/builds/slave/test', 19:24:33 INFO - 'SHELL': '/bin/bash', 19:24:33 INFO - 'SHLVL': '1', 19:24:33 INFO - 'TERM': 'linux', 19:24:33 INFO - 'TMOUT': '86400', 19:24:33 INFO - 'USER': 'cltbld', 19:24:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:33 INFO - '_': '/tools/buildbot/bin/python'} 19:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:35 INFO - Downloading docopt-0.6.1.tar.gz 19:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:36 INFO - Running setup.py install for blobuploader 19:24:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:36 INFO - Running setup.py install for requests 19:24:36 INFO - Running setup.py install for docopt 19:24:36 INFO - Successfully installed blobuploader requests docopt 19:24:36 INFO - Cleaning up... 19:24:36 INFO - Return code: 0 19:24:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:36 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:36 INFO - Using env: {'DISPLAY': ':0', 19:24:36 INFO - 'HOME': '/home/cltbld', 19:24:36 INFO - 'LANG': 'en_US.UTF-8', 19:24:36 INFO - 'LANGUAGE': 'en_US:en', 19:24:36 INFO - 'LOGNAME': 'cltbld', 19:24:36 INFO - 'MAIL': '/var/mail/cltbld', 19:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:36 INFO - 'MOZ_NO_REMOTE': '1', 19:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:36 INFO - 'NO_EM_RESTART': '1', 19:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:36 INFO - 'PWD': '/builds/slave/test', 19:24:36 INFO - 'SHELL': '/bin/bash', 19:24:36 INFO - 'SHLVL': '1', 19:24:36 INFO - 'TERM': 'linux', 19:24:36 INFO - 'TMOUT': '86400', 19:24:36 INFO - 'USER': 'cltbld', 19:24:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:36 INFO - '_': '/tools/buildbot/bin/python'} 19:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:36 INFO - Running setup.py (path:/tmp/pip-yfk3tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:36 INFO - Running setup.py (path:/tmp/pip-Soz6DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:36 INFO - Running setup.py (path:/tmp/pip-_p54PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:37 INFO - Running setup.py (path:/tmp/pip-79nObn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:37 INFO - Running setup.py (path:/tmp/pip-MQH2MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:37 INFO - Running setup.py (path:/tmp/pip-ZRnWRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:37 INFO - Running setup.py (path:/tmp/pip-MtF0gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:37 INFO - Running setup.py (path:/tmp/pip-6ECPfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:37 INFO - Running setup.py (path:/tmp/pip-7cGBIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:37 INFO - Running setup.py (path:/tmp/pip-DQ13g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:37 INFO - Running setup.py (path:/tmp/pip-yQCDJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:37 INFO - Running setup.py (path:/tmp/pip-XaYbKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:37 INFO - Running setup.py (path:/tmp/pip-vf6QOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:37 INFO - Running setup.py (path:/tmp/pip-ryGNI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:37 INFO - Running setup.py (path:/tmp/pip-IthJP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:37 INFO - Running setup.py (path:/tmp/pip-_igVMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:38 INFO - Running setup.py (path:/tmp/pip-ZyhzC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:38 INFO - Running setup.py install for manifestparser 19:24:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Running setup.py install for mozcrash 19:24:38 INFO - Running setup.py install for mozdebug 19:24:38 INFO - Running setup.py install for mozdevice 19:24:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Running setup.py install for mozfile 19:24:38 INFO - Running setup.py install for mozhttpd 19:24:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Running setup.py install for mozinfo 19:24:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Running setup.py install for mozInstall 19:24:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:38 INFO - Running setup.py install for mozleak 19:24:38 INFO - Running setup.py install for mozlog 19:24:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for moznetwork 19:24:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for mozprocess 19:24:39 INFO - Running setup.py install for mozprofile 19:24:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for mozrunner 19:24:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for mozscreenshot 19:24:39 INFO - Running setup.py install for moztest 19:24:39 INFO - Running setup.py install for mozversion 19:24:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:39 INFO - Cleaning up... 19:24:39 INFO - Return code: 0 19:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:39 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:39 INFO - Using env: {'DISPLAY': ':0', 19:24:39 INFO - 'HOME': '/home/cltbld', 19:24:39 INFO - 'LANG': 'en_US.UTF-8', 19:24:39 INFO - 'LANGUAGE': 'en_US:en', 19:24:39 INFO - 'LOGNAME': 'cltbld', 19:24:39 INFO - 'MAIL': '/var/mail/cltbld', 19:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:39 INFO - 'MOZ_NO_REMOTE': '1', 19:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:39 INFO - 'NO_EM_RESTART': '1', 19:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:39 INFO - 'PWD': '/builds/slave/test', 19:24:39 INFO - 'SHELL': '/bin/bash', 19:24:39 INFO - 'SHLVL': '1', 19:24:39 INFO - 'TERM': 'linux', 19:24:39 INFO - 'TMOUT': '86400', 19:24:39 INFO - 'USER': 'cltbld', 19:24:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:39 INFO - '_': '/tools/buildbot/bin/python'} 19:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:40 INFO - Running setup.py (path:/tmp/pip-_Av5cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:40 INFO - Running setup.py (path:/tmp/pip-Vrfqf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:40 INFO - Running setup.py (path:/tmp/pip-gFeyUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:40 INFO - Running setup.py (path:/tmp/pip-Y0HsV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:40 INFO - Running setup.py (path:/tmp/pip-aEQB0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:40 INFO - Running setup.py (path:/tmp/pip-6u6ooe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:40 INFO - Running setup.py (path:/tmp/pip-mHVMR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:40 INFO - Running setup.py (path:/tmp/pip-oq1jLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:40 INFO - Running setup.py (path:/tmp/pip-zpP3r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:40 INFO - Running setup.py (path:/tmp/pip-jm82wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:40 INFO - Running setup.py (path:/tmp/pip-GDYiPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:40 INFO - Running setup.py (path:/tmp/pip-FlrWRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:40 INFO - Running setup.py (path:/tmp/pip-AGyYTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:41 INFO - Running setup.py (path:/tmp/pip-JwBFuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:41 INFO - Running setup.py (path:/tmp/pip-0P5Xeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:41 INFO - Running setup.py (path:/tmp/pip-r6dDWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:41 INFO - Running setup.py (path:/tmp/pip-PdK9Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:43 INFO - Downloading blessings-1.6.tar.gz 19:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:43 INFO - Installing collected packages: blessings 19:24:43 INFO - Running setup.py install for blessings 19:24:43 INFO - Successfully installed blessings 19:24:43 INFO - Cleaning up... 19:24:43 INFO - Return code: 0 19:24:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:24:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:43 INFO - Reading from file tmpfile_stdout 19:24:43 INFO - Current package versions: 19:24:43 INFO - argparse == 1.2.1 19:24:43 INFO - blessings == 1.6 19:24:43 INFO - blobuploader == 1.2.4 19:24:43 INFO - docopt == 0.6.1 19:24:43 INFO - functools32 == 3.2.3-2 19:24:43 INFO - jsonschema == 2.5.1 19:24:43 INFO - manifestparser == 1.1 19:24:43 INFO - mozInstall == 1.12 19:24:43 INFO - mozcrash == 0.17 19:24:43 INFO - mozdebug == 0.1 19:24:43 INFO - mozdevice == 0.48 19:24:43 INFO - mozfile == 1.2 19:24:43 INFO - mozhttpd == 0.7 19:24:43 INFO - mozinfo == 0.9 19:24:43 INFO - mozleak == 0.1 19:24:43 INFO - mozlog == 3.4 19:24:43 INFO - moznetwork == 0.27 19:24:43 INFO - mozprocess == 0.23 19:24:43 INFO - mozprofile == 0.28 19:24:43 INFO - mozrunner == 6.12 19:24:43 INFO - mozscreenshot == 0.1 19:24:43 INFO - mozsystemmonitor == 0.3 19:24:43 INFO - moztest == 0.7 19:24:43 INFO - mozversion == 1.4 19:24:43 INFO - psutil == 3.1.1 19:24:43 INFO - requests == 1.2.3 19:24:43 INFO - wsgiref == 0.1.2 19:24:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:43 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:43 INFO - Using env: {'DISPLAY': ':0', 19:24:43 INFO - 'HOME': '/home/cltbld', 19:24:43 INFO - 'LANG': 'en_US.UTF-8', 19:24:43 INFO - 'LANGUAGE': 'en_US:en', 19:24:43 INFO - 'LOGNAME': 'cltbld', 19:24:43 INFO - 'MAIL': '/var/mail/cltbld', 19:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:43 INFO - 'MOZ_NO_REMOTE': '1', 19:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:43 INFO - 'NO_EM_RESTART': '1', 19:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:43 INFO - 'PWD': '/builds/slave/test', 19:24:43 INFO - 'SHELL': '/bin/bash', 19:24:43 INFO - 'SHLVL': '1', 19:24:43 INFO - 'TERM': 'linux', 19:24:43 INFO - 'TMOUT': '86400', 19:24:43 INFO - 'USER': 'cltbld', 19:24:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:43 INFO - '_': '/tools/buildbot/bin/python'} 19:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:24:43 INFO - Cleaning up... 19:24:43 INFO - Return code: 0 19:24:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:43 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 0x7f9f4d7b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:24:43 INFO - Using env: {'DISPLAY': ':0', 19:24:43 INFO - 'HOME': '/home/cltbld', 19:24:43 INFO - 'LANG': 'en_US.UTF-8', 19:24:43 INFO - 'LANGUAGE': 'en_US:en', 19:24:43 INFO - 'LOGNAME': 'cltbld', 19:24:43 INFO - 'MAIL': '/var/mail/cltbld', 19:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:43 INFO - 'MOZ_NO_REMOTE': '1', 19:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:43 INFO - 'NO_EM_RESTART': '1', 19:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:43 INFO - 'PWD': '/builds/slave/test', 19:24:43 INFO - 'SHELL': '/bin/bash', 19:24:43 INFO - 'SHLVL': '1', 19:24:43 INFO - 'TERM': 'linux', 19:24:43 INFO - 'TMOUT': '86400', 19:24:43 INFO - 'USER': 'cltbld', 19:24:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:43 INFO - '_': '/tools/buildbot/bin/python'} 19:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:24:44 INFO - Cleaning up... 19:24:44 INFO - Return code: 0 19:24:44 INFO - Running post-action listener: _resource_record_post_action 19:24:44 INFO - Running post-action listener: _start_resource_monitoring 19:24:44 INFO - Starting resource monitoring. 19:24:44 INFO - [mozharness: 2016-10-25 02:24:44.195939Z] Finished create-virtualenv step (success) 19:24:44 INFO - [mozharness: 2016-10-25 02:24:44.196395Z] Running install step. 19:24:44 INFO - Running pre-action listener: _resource_record_pre_action 19:24:44 INFO - Running main action method: install 19:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:44 INFO - Reading from file tmpfile_stdout 19:24:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:24:44 INFO - Reading from file tmpfile_stdout 19:24:44 INFO - Output received: 19:24:44 INFO - Usage: mozinstall [options] installer 19:24:44 INFO - Options: 19:24:44 INFO - -h, --help show this help message and exit 19:24:44 INFO - -d DEST, --destination=DEST 19:24:44 INFO - Directory to install application into. [default: 19:24:44 INFO - "/builds/slave/test"] 19:24:44 INFO - --app=APP Application being installed. [default: firefox] 19:24:44 INFO - mkdir: /builds/slave/test/build/application 19:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:25:00 INFO - Reading from file tmpfile_stdout 19:25:00 INFO - Output received: 19:25:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:25:00 INFO - Running post-action listener: _resource_record_post_action 19:25:00 INFO - [mozharness: 2016-10-25 02:25:00.452659Z] Finished install step (success) 19:25:00 INFO - [mozharness: 2016-10-25 02:25:00.452904Z] Running run-tests step. 19:25:00 INFO - Running pre-action listener: _resource_record_pre_action 19:25:00 INFO - Running main action method: run_tests 19:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:00 INFO - Python 2.7.3 19:25:00 INFO - Return code: 0 19:25:00 INFO - grabbing minidump binary from tooltool 19:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:00 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 0x28fef60>, '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 0x28ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:25:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:25:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:25:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:00 INFO - Return code: 0 19:25:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:25:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:25:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25:00 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/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:25:00 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/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:25:00 INFO - Using env: {'DISPLAY': ':0', 19:25:00 INFO - 'HOME': '/home/cltbld', 19:25:00 INFO - 'LANG': 'en_US.UTF-8', 19:25:00 INFO - 'LANGUAGE': 'en_US:en', 19:25:00 INFO - 'LOGNAME': 'cltbld', 19:25:00 INFO - 'MAIL': '/var/mail/cltbld', 19:25:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:00 INFO - 'MOZ_NO_REMOTE': '1', 19:25:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:00 INFO - 'NO_EM_RESTART': '1', 19:25:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:00 INFO - 'PWD': '/builds/slave/test', 19:25:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:00 INFO - 'SHELL': '/bin/bash', 19:25:00 INFO - 'SHLVL': '1', 19:25:00 INFO - 'TERM': 'linux', 19:25:00 INFO - 'TMOUT': '86400', 19:25:00 INFO - 'USER': 'cltbld', 19:25:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182', 19:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:00 INFO - '_': '/tools/buildbot/bin/python'} 19:25:00 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/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:25:00 INFO - mozversion application_buildid: 20161024163422 19:25:00 INFO - mozversion application_changeset: fcd7ad8a2488527ce094cbdb3582c29437c155a8 19:25:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:25:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:00 INFO - mozversion application_name: Firefox 19:25:00 INFO - mozversion application_remotingname: firefox-dev 19:25:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:25:00 INFO - mozversion application_vendor: Mozilla 19:25:00 INFO - mozversion application_version: 51.0a2 19:25:00 INFO - mozversion platform_buildid: 20161024163422 19:25:00 INFO - mozversion platform_changeset: fcd7ad8a2488527ce094cbdb3582c29437c155a8 19:25:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:25:00 INFO - mozversion platform_version: 51.0a2 19:25:00 INFO - using testdate: 1477362300 19:25:00 INFO - actual date: 1477362300 19:25:00 INFO - starting webserver on 'localhost:45693' 19:25:00 INFO - SUITE-START | Running 2 tests 19:25:00 INFO - TEST-START | dromaeo_css 19:25:00 INFO - operating with platform_type : linux_ 19:25:00 INFO - Initialising browser for dromaeo_css test... 19:25:00 INFO - TEST-INFO | started process 3255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpxA4N/profile http://localhost:45693/getInfo.html) 19:25:04 INFO - PROCESS | 3255 | __metrics Screen width/height:1600/1200 19:25:04 INFO - PROCESS | 3255 | colorDepth:24 19:25:04 INFO - PROCESS | 3255 | Browser inner width/height: 1024/697 19:25:04 INFO - PROCESS | 3255 | __metrics 19:25:05 INFO - PROCESS | 3255 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:25:05 INFO - PROCESS | 3255 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:05 INFO - PROCESS | 3255 | console.error: PushService: 19:25:05 INFO - PROCESS | 3255 | stateChangeProcessEnqueue: Error transitioning state 19:25:05 INFO - PROCESS | 3255 | UnknownError 19:25:06 INFO - TEST-INFO | 3255: exit 0 19:25:06 INFO - Browser initialized. 19:25:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:06 INFO - TEST-INFO | started process 3349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpxA4N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:18 INFO - PROCESS | 3349 | RSS: Main: 144789504 19:25:18 INFO - PROCESS | 3349 | 19:26:09 INFO - PROCESS | 3349 | 1477362369621 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:28:18 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45693/tests/dromaeo/cssquery-ext.html) 19:28:19 INFO - PROCESS | 3349 | RSS: Main: 244858880 19:28:19 INFO - PROCESS | 3349 | 19:31:22 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-ext.html (next: http://localhost:45693/tests/dromaeo/cssquery-jquery.html) 19:31:22 INFO - PROCESS | 3349 | RSS: Main: 227168256 19:31:22 INFO - PROCESS | 3349 | 19:34:24 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45693/tests/dromaeo/cssquery-mootools.html) 19:34:25 INFO - PROCESS | 3349 | RSS: Main: 174411776 19:34:25 INFO - PROCESS | 3349 | 19:37:27 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45693/tests/dromaeo/cssquery-prototype.html) 19:37:27 INFO - PROCESS | 3349 | RSS: Main: 174960640 19:37:27 INFO - PROCESS | 3349 | 19:40:30 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45693/tests/dromaeo/cssquery-yui.html) 19:40:30 INFO - PROCESS | 3349 | RSS: Main: 176844800 19:40:30 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | Cycle 1(1): loaded http://localhost:45693/tests/dromaeo/cssquery-yui.html (next: http://localhost:45693/tests/dromaeo/cssquery-dojo.html) 19:43:33 INFO - PROCESS | 3349 | RSS: Main: 263417856 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | __start_tp_report 19:43:33 INFO - PROCESS | 3349 | _x_x_mozilla_page_load 19:43:33 INFO - PROCESS | 3349 | _x_x_mozilla_page_load_details 19:43:33 INFO - PROCESS | 3349 | |i|pagename|runs| 19:43:33 INFO - PROCESS | 3349 | |0;dojo.html;3165.35110302388;3209.9037028889134;3225.3226822367287;3253.951190732138;3260.4131256373857;5584.190292407604;5663.546916246701;5668.546516278698;5683.175939488771;5693.857653558658;5654;5699.772009119641;5728;5734.168545560891;5750.856228594287;5170.405403378612;5199.168133098705;5232.084385232569;5244.239585260154;5272.446393128724;5059.519345662156;5288.973555132219;5309.30978972733;5315.123004704219;5345.278387417708;5063.949360506403;5064.113780088488;5081.237814327862;5087.338645976018;5106.953074619712;5119.283300337956;5147.356580427447;5160.664556803815;5215.660982036194;5223.764930578133;5057;5080.060188865034;5179.61152913533;5193.922091168635;5219.582433405357;5474.698891560963;5520.889582208373;5530.5022547970875;5536.75084621193;5581.972090139564;5967.8209653710455;5982.581219314649;6077.632532680156;6079.878402431971;6090.512758979271;6101.542384321194;6110.663913484756;6124.724387402578;6126.356732543108;6127.050307202391;5478.04134276504;5544.251526043973;5556.194351818964;5606.635568688022;5719.456651618089;6163.96918015416;6182.969085154546;6203.503719702413;6211.65835879031;6212.937870621236;5962.34414214436;5977.67122808241;5982.521398288127;5984.730687119003;5987.670678112659;5860.619059761102;5928.762849485972;5973.283206015219;6013.007853704177;6027.698615069229;6074.54440916933;6078.149059131725;6080.14877917092;6082.148499210114;6106.938930610637;6040.758369665252;6091.543134264948;6100.542459315569;6102.633841969496;6111.113888486145;4557.931631025537;4586.816527338936;4595.287730401793;4621.145088158702;4663.48701642819;4123.134141830249;4143.81352839123;4155.937660935088;4161.188568229166;4188.518320393194;5742.942570574324;5752.827415177551;5753.309602847685;5756.33802112754;5759.136129580596;5908.911366329508;5975.940240597625;6055.939440605625;6108.816735497942;6111;5726.198332233491;5824.155497452845;5826.184334193216;5852.736626851802;5860.501857342174;5319.654222475527;5322.600804939645;5333.866653333697;5335.11970524859;5340.465953404629;6019.548533860066;6053.061775424816;6307;6361.395667411589;6387.584806987531;6007.87984240304;6107.480864126599;6111.5110791137495;6168.568200225941;6169.321374648695;6333.145025421693;6339.270983836917;6343.207099112611;6345.302016778243;6353.174087368612;5742.253507044057;6032.306284777132;6033.78881739137;6037.335893051673;6037.969810150921;5951.28584569837;5969.044952807703;6007.189029480965;6025.78909738157;6126.754929802758;5896.528277737856;5932.703364831655;5938.257717785277;5941.58408911372;5949;5941.197938278277;5941.435563621449;5950.851228719317;5952.76188952437;5956.106584012433;5625.662460252398;5766.3368712598585;5837.270341207349;5887.5289976802605;5900.468957793819;6041.969790151021;6043.728032238472;6046.848828779316;6054.122152287806;6054.697265136638;5542.889142217214;5879.118132280192;5896.7936122235515;5909.349971503218;5910.290765108214 19:43:33 INFO - PROCESS | 3349 | |1;ext.html;585.5345000724424;615.2709039787849;615.7260019291415;635.844218166549;650.879587276354;37946.241075178514;38512;46702.76648616752;47351.763241183835;47506.28740568894;49505.75247123768;49756;49871.50128498714;49921;49955.25067123987;9225.677101301455;9410;9413.199878010377;9425.622975080989;9426.717198484057;8515.403921725481;8755.956220218923;10901.672949811518;11146.888531114666;11163.83254251187;11331;11405.37270450125;11429.828552571718;11437.085033197365;11444.542218311299;11096.500657470393;11138.665840024812;11166.050885674727;11169.83245251322;11211.66365009051;11029.889701102966;11110.555577776879;11111.000009999058;11115.944420277927;11119.221654484189;45975.080498390176;46116.76941615304;46124;46135.077298454176;46158;3863.343231650626;3893.669038131734;3945.4649941541534;4056.695747818896;4092.7953602319767;34215.14462138442;34424.64083761282;34472.389420315245;34536.136596585035;35066.6493335066;4445.711028783118;4449.065696203801;4461.5092339842595;4535.546445355471;4603.746793926332;374807;375568;376277;378012;378730;65506.34493655098;65516.34483655198;65833.34166658368;65834.67082664651;65863;40599.59400405958;41709.58290417118;41800.79099604482;43870;43898;17516;17637.82362176362;17640.911795441196;17644.735328970077;17648.294068237385;12219.877801222052;12388.442520086617;12403.689907752198;12433.316167610868;12474.625761227178;18037.549061273574;19702.901485492766;20381.490462738253;20462.590748184954;21298.148074077173;7584.848303033908;7595.354394876387;7759.495632783851;7776.750693282012;7935.64289606969;1021.5658345203259;1076.967690969272;1092.3937214845678;1123.1351859068634;1162.9302241865514;35192.824035879654;35237.82381088078;35654.28691426209;35687.64312356895;35742.74900378526;1140.4126874659557;1145.833854091152;1173.4602083041725;1187.2105050141558;1195.1036722458157;18477.445676629453;18510.722339164924;18580.349687760863;18606.81393186078;18610.44168674942;590280;595304;596527;596538;597181;63624.68187659032;64006;64343;64370.35629643737;64384;1319.8680131986916;1369.8561651026498;1432.3196481671332;1445.8915581331441;1476.8080149580485;32152.678473214968;35643.64356356403;35843.28313433769;35966;36357.81821090878;56468;56938.430615693316;57277.713611431675;57316.42683573111;57320.71339643275;410704;411885;412390;415286;415524;31325.68674313319;31411.528827067155;31874.20314492156;32301.192470187492;33843.323133537684;51485.7425712884;51564;52102;52377.214341785664;53127;43274.567254328314;43473.78263108791;44038;44166;45028.549714502435;42192.854620422884;43944;44176.77911610421;44613;45811.083778324915;39980.800575982765;44417;44612.55387446084;45471.772641137904;45474.772626136655;35883.461748074325;38273.808630956664;39237.607623923395;39331.2133757329;39390.606093938695;29376.531173440813;29773.702262977095;29893.850530747208;30154.396912062075;30194.69805301919 19:43:33 INFO - PROCESS | 3349 | |2;jquery.html;400.125725290241;410.1223381962599;423.9745615263083;425.7296616648428;432.3752178102641;14703.632409189762;16402.179891005446;20253.898730506346;20878.582428351423;21243.6813447798;19200.903995480003;19617.215311387565;19669.704954425695;20137.59724805503;20767.169313227452;5863.208466856983;5928.703564821763;6015.0676645120075;6040.822039702238;6061.060535616986;5979.581429299951;6073.574849760518;6074.605150665215;6078.422549857756;6081.361457047013;4217.557156498569;4443.688941774077;4542.750148741818;6674.899876501856;6754.358335958076;6684.398404143651;6726.966365168192;6797.660116994155;6818.045473633695;6838.487113466485;5991.221141251653;6016.2479690038745;6026.0960855871535;6030.366811484819;6041.365656606081;23828.64257036146;24358.39104022396;24435.63346549803;24566.877165614056;24726.258212253662;2550.13295479536;2628.6451329070524;2630;2754.724527547249;2986.522156454957;15364.923175384052;15509.5347139586;15519.3016314265;15536.844631553766;15809.60475988098;1983.3256692724399;2073.6889466579983;2093.0685844799073;2144.3352560706076;2228.275810361639;85655.57172214099;88377.11622883753;89235.55382223113;89265;89409;11170.664880053611;11203.831942520868;11241.550337986553;11496.655100347003;11808.228765685044;16286.26711797972;16308.673826523403;16316.592085197728;16324.836751632569;16347.754783678254;9005.459672419676;9027.864582031143;9193.080691930754;9222.584983675752;9351.579178936965;9140.771480713036;9165.541722913827;9207.217386522087;9322.114399132071;9397.483138427453;6723.630200339028;6806.93193068063;6830.180378354629;6880.208775990725;6936.410405115622;1930.4112245764895;2068.841448788683;2086.1759604955955;2101.2750601042617;2121.9257325993517;809.6316176139842;958.5878072428923;983.2871168402851;1059.7933402986498;1090.7872964771952;12810.743785124245;13585.116967397087;20432.693509597368;21552.168065714275;21579.028943697256;500.4495055438988;509.3792437906948;515.0702981119041;517.4747631154381;518.6058595467397;6787.830304242433;7212.567245965259;7278.526895751759;7290.9635451822405;7366.226546212678;465338;479358;479921;486279;520519;97291;98638;99146;101084;101327.4933625342;517.6247220764915;526.9156934890399;527.5911168844176;528.3501293409129;529.3594750352117;12165.635030949086;12210.938945305217;12383.318917459626;12513.436895339913;12556.811647825472;43820.56179438165;44611.10777784491;45282.547174527834;45488.54511454843;46395.304070438295;61062.084068739896;61853;62478.687606561674;62560;63653.363466364746;9208.447493150432;9285.164335209864;9296.628134874529;9314.394564353295;9387.436753794795;13089.214647121204;13164.868351316747;13327.333633318489;13766.31168441594;13996.930015349859;10921.470994060679;11558.248713833911;11927.76144477123;12170.208936419105;12453.003759699384;11798.469068891749;12089.032877369613;12153.331566763913;12153.635390938285;12443.626691199279;11820.40897955116;11979.221350612183;12171.14801963854;12748.4263208154;12983.935080324538;9282.860757088514;9453.952730236304;9488.762780930532;9604.279679024241;9742.31803773729;11995.520179192734;12459.12786104964;12531.436085375997;12718.554850580185;12872.292023938773 19:43:33 INFO - PROCESS | 3349 | |3;mootools.html;1537.292845291166;1562.9218539073047;1713.6315692126198;1830.0575203770052;1843.7879643840963;9109.271258299337;9823.410595364274;9838.60645574178;9840.360376575518;9852.556634951427;8012.439129260954;8257.463264887778;8266.50400975942;8507.319414446845;9570.904290957089;2466.457379376539;2567.4479986802835;2573.7040240372316;2587.081586036958;2590.8575028373434;2542.8855701493385;2572.4726431081676;2608.660874086366;2636.6440530528325;2640.551106311922;2522.735112813156;2533.138732830837;2533.278015765507;2548.566743653583;2609.0346571768378;2500.949981000379;2510.4853505031515;2512.271441282044;2514.823962322638;2515.8490490570443;2525.1414519063605;2528.5575024370846;2529.45616692412;2558.6162075688794;2560.2319304208663;9589.664361747375;9674.951625241829;9676.371035882716;9690.70927872165;9691.70924872255;5645.717714114277;5901.527877769769;5903.675297858616;5907;5911.793087241969;3472.2187507810795;3579.069441945087;3655.4882316475714;3660.652238037382;3660.8535658573624;1166.9264276865304;1188.144535934126;1209.6129238643637;1223.5350566784655;1225.6078055022397;13536.796948045787;13595.04834661574;13622;13650.180989140585;13650.590482285448;5118.61610379223;5235.424103348705;5326.280952071498;5335.11970524859;5414.729263536808;11469.369184694922;11473.196876218584;11504.712382190512;11526.135539834546;11536.365499897418;5942.554308426886;5984.401559843981;5990.281166260077;5995.250593675791;5997.580169388189;5323.893522129613;5340.012097761926;5395.2986111806;5460.044492213847;5474;4255.6169944705125;4389.209942210433;4457.576530229623;4543.931841022388;4545.36364908913;1430.4206796247536;1462.2396353895915;1468.6695493514087;1470.3897882378908;1471.0438215160232;964.3538828984597;1000.9949950250348;1008.6318493749875;1024.948752562369;1030.2891005206384;6277.372262773686;6461.709223084972;6492.188476440445;6519.576227545194;6671.933280667228;521.1687358662926;521.8904030153634;524.8241838983906;536.2037374498866;538.4292649791233;4188.643965262926;4343.326784348431;4438.289873620205;4566.178087944202;4568.132054909623;11332.150088743378;11953.282803031845;11954.58158964432;11956.163068585116;11970.940145299217;11242.66272011841;11888.940555297168;11924.344161071225;11946.820797688042;11948.701282467833;8629.956850215834;9015.594298256594;9025.277977761763;9048.728538143867;9055.094490551024;6562.901556476752;6600.768973085919;6641.402273795382;6732.899006514808;6837.521373504006;10455.581776728846;11238.606648767254;11247.381394023407;11312.03847672957;11408.429578521207;9909.355891867293;11037.061849742862;11130.109591232844;11276.154288428237;11280.548778049115;7475.887861682188;7928.881066784118;8167.1424500428975;8220.684690449738;8389.496630202208;9205.76985575366;9221.49281789508;9319.207867331354;9374.484403357881;9409.623615055321;7976.561289129154;8046.476978996347;8194.057683366489;8208.261256486707;8373.665053397795;7983.680652774056;8109.959450202711;8148.877766833621;8253.95873020631;8284.875726864222;7375.704971801068;7481.588512631857;7484.32641062307;7490.962545187239;7503.062117235346;5357.089294819968;5440.183972404171;5469.535089517276;5487.286652735279;5677.829665110054;5530.115181570929;5560.5829562783765;5612.494875461228;5728.942710573007;5790.565707571865 19:43:33 INFO - PROCESS | 3349 | |4;prototype.html;349.43915016398665;354.2419222863073;354.88998410492746;355.87366484897854;358.81162389745396;5561.443855614437;5592.328920529532;5600.775968961237;5605.691686957216;5647.717614119299;5491.917621235684;5498.505134537891;5505.779768809243;5517.944820551793;5531.944680553203;3870.3807390817474;4098.01647604575;4192.601702838241;4300.78496075195;4390.582894625006;4359.3025115981445;4363.956360436403;4370.453693288339;4383.780810959455;4387.736735795863;4335.371371151181;4364.410804541394;4397.230484665187;4404.713693609921;4407.823687052514;4077.607672016352;4171.144915292358;4360.56394360563;4394.956345299419;4424.358468022151;3870.9612903870884;3891.727579069466;3907.1404291055924;3939.763614183158;3941.2905676978135;5354.4125435958;5385.946140538584;5396.514313711785;5398.460153984609;5457.808976685797;4704.741239231841;4947.282644016597;4988.501149885019;5042.571381432546;5064.265681476165;5699.401562835926;5710.828675139711;5716.514096301819;5742.971285143548;5759.68321742304;4229.281022226198;4239.215745087169;4243.745375277494;4244.978775106136;4249.810053185113;5759.539236861041;5906.26171728534;5940.673262970535;5965.522758179335;6057.394260573951;4274.829006839754;4280.850170244026;4297.871063868089;4301.634361079344;4314.848980285675;4358.978205109018;4362.323839804835;4365.847195348148;4367.825286988485;4410.823567057346;4763.404574428197;4973.850784476399;5002.924956125661;5017.172166592544;5020.66952257652;5753.899826563358;5795.507381872504;5827.213326200994;5831.912521312183;5838.357780644125;1495.424261659269;1510.4562357551272;1511.8866085043667;1514.8257950335853;1514.9318280677176;973.5667627905656;990.2770977186694;991.6083147156977;1036.1658864614058;1059.5179193466954;5506.1190209566275;5514.862128446741;5528.474794894479;5536.280283563111;5540.141278101901;5894.233749612523;5898.262717160355;5930.71667408051;5930.8813823723285;5952.375000624872;5350.117230656898;5578.972105139448;5622.32532096151;5633.155026746021;5661.405552417019;3147.779655424144;3177.7616678749187;3187.5815262208093;3196;3198.792078514936;5955.017422125387;6156.445919867234;6165.70520190756;6171.691415429211;6183.876322473526;5844.678542680108;6144.907826382608;6155.907661385083;6162.291336496271;6171.13604095427;6050.788222412194;6085.300190478063;6088.817335479854;6178.351273116348;6178.752849885954;5938.317093534126;5961.463468287875;5967;5980.312264089685;5987.820365389045;5626.662400255997;5903.91144132847;5921.733521991435;5962.880742385215;5965.403459654173;6183.96908015457;6195.597286176384;6195.690215489298;6202.805555139017;6214.9067763982675;4120.670346372223;4331.328644060176;4334.068175342317;4363.4981977071775;4382.956170438255;5945.672987985529;5948.464638182584;5950.940490595039;5955.5235581154275;5974.40255974399;5827.125931110368;5847;5850.0932355484965;5857.690404921206;5857.912131318119;5675.375708671961;5775.48020678141;5777.62445441045;5819.621724587888;5826.679532625577;5692.6299790513485;5727.8568035799435;5729.942700573108;5745.569082318759;5760.884782304414;5630.887382252414;5777.3933736957015;5797.59416840834;5806.44838740319;5836.941630583639;5680.744366503434;5685.971570142123;5698.629589076697;5699.373068962328;5711.200431939615 19:43:33 INFO - PROCESS | 3349 | |5;yui.html;804.203838200182;820;836.431226765799;842.8651415773477;898.9775255618605;16196.838031619694;17810.64378712428;18014.81985180148;18070.09649517524;18096.54758631033;16207.108609026498;16260;16271.51185464435;16440.588985275375;16448.67102657946;823.7652269103306;846.932245420368;849.7026040885702;849.7408290471403;851.9190676885686;700.898369736388;729.1833146875507;805.0982899152928;850.2857599616322;855.4396870050127;903.56628818167;906.4697152165991;906.9637214511412;908.1191244492832;909.1499448016126;903.7966457547033;905.1898550797;905.714699869539;906.0441234497636;906.3202598051462;531.346443874037;553.1371061144587;623.0622912516678;653.6470306034736;659.0443856408227;15431.691366172727;15491.922540387339;15511.5346539604;15541.378344866192;15560.533184004498;14969.850301496954;15471.922640386838;15552;15597.298121584556;15725.213739312989;14066.2966851657;14196.361163747657;14225.573232803032;14236.359363828653;14299.856011519054;4723.574878260973;4769.976150119262;4772.188727916227;4785.641076919245;4851.151048566487;88001.55999219963;90220.54889725575;91664.99999999933;92308.07691923062;92577.537112314;11491.42542872853;11755.412229388667;11773.411329433495;11844.348560829238;12086.39568021613;22265.332040038826;22295.442613934458;22297.442563935707;22335;22350.441238969157;8717.215450609476;8809.867851982226;8838.425502342327;8906.287497000225;9220.354575179806;5121.4878512149235;5124.180131178993;5196.714180720097;5329.840104796862;5339.41266460689;3730.645588669072;3820.84716611338;3845.442410850467;3852.8844134676006;3853.5183102112237;612.3723183736705;622.6979914741347;668.6055227415848;699.101654374137;714.4213187318185;656.7635651165576;745.198911170483;752.4319139049982;760.1410406240913;780.434185215714;10352.689419317432;10536.525856336484;10554.841677374845;10569.682909512727;10683.893161068445;677.5732180270134;687.4328678839977;691.4330249195611;774.9263819937097;805.4965646470955;5013.24801279811;5242.397124330674;5281.419043905167;5305.602079844027;5316.149416093406;109099.45450272698;109525;113160;120164.39917800356;133695.33152334372;106543.84974085508;107305.46347268214;109487;110854.44572777246;113001.4349928245;92333.53833230791;94180.52909735407;94298.5285073584;95421.5228923851;96357;10632.096271816983;10801.837972430263;10969.451527423438;11074.778504430027;11175.38535380562;50436;51138.74430627823;51448.22827657513;53826.46173538371;54945;72241.6387918057;72260;80240;80626.59686701764;82401.58799205965;13438.260895650443;13678.52125175654;13723.451061957809;13828.723425531232;13932.93033534826;14933.253337333308;15006.006589802222;15136.924315378352;15315.081095134328;15559.922200388926;11755.706107347385;14765.630859228606;15745.606359841096;15958;15996.280167392262;14093.683526792724;14757.188354640597;14770.33533490974;14836.851631483547;14975.1014939104;12915.354232288535;13092.541761038317;13095.476180952655;13369.331533423485;13626.386812593655;12047.397630118634;12790.36048197605;12988.610341689764;13159.407826647632;13323.200607963554;12677.87322126767;12818.74362512726;12846.871531284567;12892.162009469355;13072.803907941197 19:43:33 INFO - PROCESS | 3349 | __end_tp_report 19:43:33 INFO - PROCESS | 3349 | __start_cc_report 19:43:33 INFO - PROCESS | 3349 | _x_x_mozilla_cycle_collect,936 19:43:33 INFO - PROCESS | 3349 | __end_cc_report 19:43:33 INFO - PROCESS | 3349 | __startTimestamp1477363413801__endTimestamp 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | ------- Summary: start ------- 19:43:33 INFO - PROCESS | 3349 | Number of tests: 6 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#0] dojo.html Cycles:165 Average:5635.91 Median:5887.53 stddev:645.97 (11.0%) stddev-sans-first:618.19 19:43:33 INFO - PROCESS | 3349 | Values: 3165.4 3209.9 3225.3 3254.0 3260.4 5584.2 5663.5 5668.5 5683.2 5693.9 5654.0 5699.8 5728.0 5734.2 5750.9 5170.4 5199.2 5232.1 5244.2 5272.4 5059.5 5289.0 5309.3 5315.1 5345.3 5063.9 5064.1 5081.2 5087.3 5107.0 5119.3 5147.4 5160.7 5215.7 5223.8 5057.0 5080.1 5179.6 5193.9 5219.6 5474.7 5520.9 5530.5 5536.8 5582.0 5967.8 5982.6 6077.6 6079.9 6090.5 6101.5 6110.7 6124.7 6126.4 6127.1 5478.0 5544.3 5556.2 5606.6 5719.5 6164.0 6183.0 6203.5 6211.7 6212.9 5962.3 5977.7 5982.5 5984.7 5987.7 5860.6 5928.8 5973.3 6013.0 6027.7 6074.5 6078.1 6080.1 6082.1 6106.9 6040.8 6091.5 6100.5 6102.6 6111.1 4557.9 4586.8 4595.3 4621.1 4663.5 4123.1 4143.8 4155.9 4161.2 4188.5 5742.9 5752.8 5753.3 5756.3 5759.1 5908.9 5975.9 6055.9 6108.8 6111.0 5726.2 5824.2 5826.2 5852.7 5860.5 5319.7 5322.6 5333.9 5335.1 5340.5 6019.5 6053.1 6307.0 6361.4 6387.6 6007.9 6107.5 6111.5 6168.6 6169.3 6333.1 6339.3 6343.2 6345.3 6353.2 5742.3 6032.3 6033.8 6037.3 6038.0 5951.3 5969.0 6007.2 6025.8 6126.8 5896.5 5932.7 5938.3 5941.6 5949.0 5941.2 5941.4 5950.9 5952.8 5956.1 5625.7 5766.3 5837.3 5887.5 5900.5 6042.0 6043.7 6046.8 6054.1 6054.7 5542.9 5879.1 5896.8 5909.3 5910.3 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#1] ext.html Cycles:180 Average:63498.15 Median:39360.91 stddev:124980.85 (317.5%) stddev-sans-first:125242.20 19:43:33 INFO - PROCESS | 3349 | Values: 585.5 615.3 615.7 635.8 650.9 37946.2 38512.0 46702.8 47351.8 47506.3 49505.8 49756.0 49871.5 49921.0 49955.3 9225.7 9410.0 9413.2 9425.6 9426.7 8515.4 8756.0 10901.7 11146.9 11163.8 11331.0 11405.4 11429.8 11437.1 11444.5 11096.5 11138.7 11166.1 11169.8 11211.7 11029.9 11110.6 11111.0 11115.9 11119.2 45975.1 46116.8 46124.0 46135.1 46158.0 3863.3 3893.7 3945.5 4056.7 4092.8 34215.1 34424.6 34472.4 34536.1 35066.6 4445.7 4449.1 4461.5 4535.5 4603.7 374807.0 375568.0 376277.0 378012.0 378730.0 65506.3 65516.3 65833.3 65834.7 65863.0 40599.6 41709.6 41800.8 43870.0 43898.0 17516.0 17637.8 17640.9 17644.7 17648.3 12219.9 12388.4 12403.7 12433.3 12474.6 18037.5 19702.9 20381.5 20462.6 21298.1 7584.8 7595.4 7759.5 7776.8 7935.6 1021.6 1077.0 1092.4 1123.1 1162.9 35192.8 35237.8 35654.3 35687.6 35742.7 1140.4 1145.8 1173.5 1187.2 1195.1 18477.4 18510.7 18580.3 18606.8 18610.4 590280.0 595304.0 596527.0 596538.0 597181.0 63624.7 64006.0 64343.0 64370.4 64384.0 1319.9 1369.9 1432.3 1445.9 1476.8 32152.7 35643.6 35843.3 35966.0 36357.8 56468.0 56938.4 57277.7 57316.4 57320.7 410704.0 411885.0 412390.0 415286.0 415524.0 31325.7 31411.5 31874.2 32301.2 33843.3 51485.7 51564.0 52102.0 52377.2 53127.0 43274.6 43473.8 44038.0 44166.0 45028.5 42192.9 43944.0 44176.8 44613.0 45811.1 39980.8 44417.0 44612.6 45471.8 45474.8 35883.5 38273.8 39237.6 39331.2 39390.6 29376.5 29773.7 29893.9 30154.4 30194.7 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#2] jquery.html Cycles:180 Average:29754.15 Median:24132.13 stddev:80584.21 (333.9%) stddev-sans-first:80780.12 19:43:33 INFO - PROCESS | 3349 | Values: 400.1 410.1 424.0 425.7 432.4 14703.6 16402.2 20253.9 20878.6 21243.7 19200.9 19617.2 19669.7 20137.6 20767.2 5863.2 5928.7 6015.1 6040.8 6061.1 5979.6 6073.6 6074.6 6078.4 6081.4 4217.6 4443.7 4542.8 6674.9 6754.4 6684.4 6727.0 6797.7 6818.0 6838.5 5991.2 6016.2 6026.1 6030.4 6041.4 23828.6 24358.4 24435.6 24566.9 24726.3 2550.1 2628.6 2630.0 2754.7 2986.5 15364.9 15509.5 15519.3 15536.8 15809.6 1983.3 2073.7 2093.1 2144.3 2228.3 85655.6 88377.1 89235.6 89265.0 89409.0 11170.7 11203.8 11241.6 11496.7 11808.2 16286.3 16308.7 16316.6 16324.8 16347.8 9005.5 9027.9 9193.1 9222.6 9351.6 9140.8 9165.5 9207.2 9322.1 9397.5 6723.6 6806.9 6830.2 6880.2 6936.4 1930.4 2068.8 2086.2 2101.3 2121.9 809.6 958.6 983.3 1059.8 1090.8 12810.7 13585.1 20432.7 21552.2 21579.0 500.4 509.4 515.1 517.5 518.6 6787.8 7212.6 7278.5 7291.0 7366.2 465338.0 479358.0 479921.0 486279.0 520519.0 97291.0 98638.0 99146.0 101084.0 101327.5 517.6 526.9 527.6 528.4 529.4 12165.6 12210.9 12383.3 12513.4 12556.8 43820.6 44611.1 45282.5 45488.5 46395.3 61062.1 61853.0 62478.7 62560.0 63653.4 9208.4 9285.2 9296.6 9314.4 9387.4 13089.2 13164.9 13327.3 13766.3 13996.9 10921.5 11558.2 11927.8 12170.2 12453.0 11798.5 12089.0 12153.3 12153.6 12443.6 11820.4 11979.2 12171.1 12748.4 12983.9 9282.9 9454.0 9488.8 9604.3 9742.3 11995.5 12459.1 12531.4 12718.6 12872.3 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#3] mootools.html Cycles:180 Average:6296.84 Median:2878.66 stddev:3593.23 (124.8%) stddev-sans-first:3585.51 19:43:33 INFO - PROCESS | 3349 | Values: 1537.3 1562.9 1713.6 1830.1 1843.8 9109.3 9823.4 9838.6 9840.4 9852.6 8012.4 8257.5 8266.5 8507.3 9570.9 2466.5 2567.4 2573.7 2587.1 2590.9 2542.9 2572.5 2608.7 2636.6 2640.6 2522.7 2533.1 2533.3 2548.6 2609.0 2500.9 2510.5 2512.3 2514.8 2515.8 2525.1 2528.6 2529.5 2558.6 2560.2 9589.7 9675.0 9676.4 9690.7 9691.7 5645.7 5901.5 5903.7 5907.0 5911.8 3472.2 3579.1 3655.5 3660.7 3660.9 1166.9 1188.1 1209.6 1223.5 1225.6 13536.8 13595.0 13622.0 13650.2 13650.6 5118.6 5235.4 5326.3 5335.1 5414.7 11469.4 11473.2 11504.7 11526.1 11536.4 5942.6 5984.4 5990.3 5995.3 5997.6 5323.9 5340.0 5395.3 5460.0 5474.0 4255.6 4389.2 4457.6 4543.9 4545.4 1430.4 1462.2 1468.7 1470.4 1471.0 964.4 1001.0 1008.6 1024.9 1030.3 6277.4 6461.7 6492.2 6519.6 6671.9 521.2 521.9 524.8 536.2 538.4 4188.6 4343.3 4438.3 4566.2 4568.1 11332.2 11953.3 11954.6 11956.2 11970.9 11242.7 11888.9 11924.3 11946.8 11948.7 8630.0 9015.6 9025.3 9048.7 9055.1 6562.9 6600.8 6641.4 6732.9 6837.5 10455.6 11238.6 11247.4 11312.0 11408.4 9909.4 11037.1 11130.1 11276.2 11280.5 7475.9 7928.9 8167.1 8220.7 8389.5 9205.8 9221.5 9319.2 9374.5 9409.6 7976.6 8046.5 8194.1 8208.3 8373.7 7983.7 8110.0 8148.9 8254.0 8284.9 7375.7 7481.6 7484.3 7491.0 7503.1 5357.1 5440.2 5469.5 5487.3 5677.8 5530.1 5560.6 5612.5 5728.9 5790.6 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#4] prototype.html Cycles:180 Average:4901.07 Median:5596.55 stddev:1426.82 (25.5%) stddev-sans-first:1389.32 19:43:33 INFO - PROCESS | 3349 | Values: 349.4 354.2 354.9 355.9 358.8 5561.4 5592.3 5600.8 5605.7 5647.7 5491.9 5498.5 5505.8 5517.9 5531.9 3870.4 4098.0 4192.6 4300.8 4390.6 4359.3 4364.0 4370.5 4383.8 4387.7 4335.4 4364.4 4397.2 4404.7 4407.8 4077.6 4171.1 4360.6 4395.0 4424.4 3871.0 3891.7 3907.1 3939.8 3941.3 5354.4 5385.9 5396.5 5398.5 5457.8 4704.7 4947.3 4988.5 5042.6 5064.3 5699.4 5710.8 5716.5 5743.0 5759.7 4229.3 4239.2 4243.7 4245.0 4249.8 5759.5 5906.3 5940.7 5965.5 6057.4 4274.8 4280.9 4297.9 4301.6 4314.8 4359.0 4362.3 4365.8 4367.8 4410.8 4763.4 4973.9 5002.9 5017.2 5020.7 5753.9 5795.5 5827.2 5831.9 5838.4 1495.4 1510.5 1511.9 1514.8 1514.9 973.6 990.3 991.6 1036.2 1059.5 5506.1 5514.9 5528.5 5536.3 5540.1 5894.2 5898.3 5930.7 5930.9 5952.4 5350.1 5579.0 5622.3 5633.2 5661.4 3147.8 3177.8 3187.6 3196.0 3198.8 5955.0 6156.4 6165.7 6171.7 6183.9 5844.7 6144.9 6155.9 6162.3 6171.1 6050.8 6085.3 6088.8 6178.4 6178.8 5938.3 5961.5 5967.0 5980.3 5987.8 5626.7 5903.9 5921.7 5962.9 5965.4 6184.0 6195.6 6195.7 6202.8 6214.9 4120.7 4331.3 4334.1 4363.5 4383.0 5945.7 5948.5 5950.9 5955.5 5974.4 5827.1 5847.0 5850.1 5857.7 5857.9 5675.4 5775.5 5777.6 5819.6 5826.7 5692.6 5727.9 5729.9 5745.6 5760.9 5630.9 5777.4 5797.6 5806.4 5836.9 5680.7 5686.0 5698.6 5699.4 5711.2 19:43:33 INFO - PROCESS | 3349 | 19:43:33 INFO - PROCESS | 3349 | [#5] yui.html Cycles:180 Average:22472.74 Median:3775.75 stddev:32261.97 (854.5%) stddev-sans-first:32311.45 19:43:33 INFO - PROCESS | 3349 | Values: 804.2 820.0 836.4 842.9 899.0 16196.8 17810.6 18014.8 18070.1 18096.5 16207.1 16260.0 16271.5 16440.6 16448.7 823.8 846.9 849.7 849.7 851.9 700.9 729.2 805.1 850.3 855.4 903.6 906.5 907.0 908.1 909.1 903.8 905.2 905.7 906.0 906.3 531.3 553.1 623.1 653.6 659.0 15431.7 15491.9 15511.5 15541.4 15560.5 14969.9 15471.9 15552.0 15597.3 15725.2 14066.3 14196.4 14225.6 14236.4 14299.9 4723.6 4770.0 4772.2 4785.6 4851.2 88001.6 90220.5 91665.0 92308.1 92577.5 11491.4 11755.4 11773.4 11844.3 12086.4 22265.3 22295.4 22297.4 22335.0 22350.4 8717.2 8809.9 8838.4 8906.3 9220.4 5121.5 5124.2 5196.7 5329.8 5339.4 3730.6 3820.8 3845.4 3852.9 3853.5 612.4 622.7 668.6 699.1 714.4 656.8 745.2 752.4 760.1 780.4 10352.7 10536.5 10554.8 10569.7 10683.9 677.6 687.4 691.4 774.9 805.5 5013.2 5242.4 5281.4 5305.6 5316.1 109099.5 109525.0 113160.0 120164.4 133695.3 106543.8 107305.5 109487.0 110854.4 113001.4 92333.5 94180.5 94298.5 95421.5 96357.0 10632.1 10801.8 10969.5 11074.8 11175.4 50436.0 51138.7 51448.2 53826.5 54945.0 72241.6 72260.0 80240.0 80626.6 82401.6 13438.3 13678.5 13723.5 13828.7 13932.9 14933.3 15006.0 15136.9 15315.1 15559.9 11755.7 14765.6 15745.6 15958.0 15996.3 14093.7 14757.2 14770.3 14836.9 14975.1 12915.4 13092.5 13095.5 13369.3 13626.4 12047.4 12790.4 12988.6 13159.4 13323.2 12677.9 12818.7 12846.9 12892.2 13072.8 19:43:33 INFO - PROCESS | 3349 | -------- Summary: end -------- 19:43:33 INFO - PROCESS | 3349 | 19:43:34 INFO - TEST-INFO | 3349: exit 0 19:43:34 INFO - TEST-OK | dromaeo_css | took 1113862ms 19:43:34 INFO - TEST-START | kraken 19:43:34 INFO - operating with platform_type : linux_ 19:43:34 INFO - Initialising browser for kraken test... 19:43:34 INFO - TEST-INFO | started process 3666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzqadhZ/profile http://localhost:45693/getInfo.html) 19:43:38 INFO - PROCESS | 3666 | __metrics Screen width/height:1600/1200 19:43:38 INFO - PROCESS | 3666 | colorDepth:24 19:43:38 INFO - PROCESS | 3666 | Browser inner width/height: 1024/697 19:43:38 INFO - PROCESS | 3666 | __metrics 19:43:38 INFO - PROCESS | 3666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:43:38 INFO - PROCESS | 3666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:43:39 INFO - PROCESS | 3666 | console.error: PushService: 19:43:39 INFO - PROCESS | 3666 | stateChangeProcessEnqueue: Error transitioning state 19:43:39 INFO - PROCESS | 3666 | UnknownError 19:43:39 INFO - TEST-INFO | 3666: exit 0 19:43:39 INFO - Browser initialized. 19:43:39 INFO - Running cycle 1/1 for kraken test... 19:43:39 INFO - TEST-INFO | started process 3757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzqadhZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:51 INFO - PROCESS | 3757 | RSS: Main: 145022976 19:43:51 INFO - PROCESS | 3757 | 19:43:54 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45693/tests/kraken/driver.html?testName=audio-beat-detection) 19:43:55 INFO - PROCESS | 3757 | RSS: Main: 186847232 19:43:55 INFO - PROCESS | 3757 | 19:43:57 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45693/tests/kraken/driver.html?testName=audio-dft) 19:43:58 INFO - PROCESS | 3757 | RSS: Main: 176197632 19:43:58 INFO - PROCESS | 3757 | 19:44:01 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45693/tests/kraken/driver.html?testName=audio-fft) 19:44:01 INFO - PROCESS | 3757 | RSS: Main: 267776000 19:44:01 INFO - PROCESS | 3757 | 19:44:03 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45693/tests/kraken/driver.html?testName=audio-oscillator) 19:44:04 INFO - PROCESS | 3757 | RSS: Main: 173711360 19:44:04 INFO - PROCESS | 3757 | 19:44:06 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:07 INFO - PROCESS | 3757 | RSS: Main: 175136768 19:44:07 INFO - PROCESS | 3757 | 19:44:10 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45693/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:10 INFO - PROCESS | 3757 | RSS: Main: 211066880 19:44:10 INFO - PROCESS | 3757 | 19:44:13 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45693/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:14 INFO - PROCESS | 3757 | RSS: Main: 209747968 19:44:14 INFO - PROCESS | 3757 | 19:44:17 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45693/tests/kraken/driver.html?testName=json-parse-financial) 19:44:17 INFO - PROCESS | 3757 | RSS: Main: 209494016 19:44:17 INFO - PROCESS | 3757 | 19:44:19 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:19 INFO - PROCESS | 3757 | RSS: Main: 171139072 19:44:19 INFO - PROCESS | 3757 | 19:44:21 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:22 INFO - PROCESS | 3757 | RSS: Main: 180092928 19:44:22 INFO - PROCESS | 3757 | 19:44:24 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:24 INFO - PROCESS | 3757 | RSS: Main: 188702720 19:44:24 INFO - PROCESS | 3757 | 19:44:27 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:28 INFO - PROCESS | 3757 | RSS: Main: 197353472 19:44:28 INFO - PROCESS | 3757 | 19:44:30 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:31 INFO - PROCESS | 3757 | RSS: Main: 193630208 19:44:31 INFO - PROCESS | 3757 | 19:44:32 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:45693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45693/tests/kraken/driver.html?testName=ai-astar) 19:44:33 INFO - PROCESS | 3757 | RSS: Main: 244162560 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | __start_tp_report 19:44:33 INFO - PROCESS | 3757 | _x_x_mozilla_page_load 19:44:33 INFO - PROCESS | 3757 | _x_x_mozilla_page_load_details 19:44:33 INFO - PROCESS | 3757 | |i|pagename|runs| 19:44:33 INFO - PROCESS | 3757 | |0;ai-astar;109;110;108;110;110;110;112;111;110;112 19:44:33 INFO - PROCESS | 3757 | |1;audio-beat-detection;146;120;116;157;116;123;119;118;153;121 19:44:33 INFO - PROCESS | 3757 | |2;audio-dft;161;163;160;160;161;160;159;161;161;160 19:44:33 INFO - PROCESS | 3757 | |3;audio-fft;75;76;77;114;75;74;75;74;98;75 19:44:33 INFO - PROCESS | 3757 | |4;audio-oscillator;82;81;120;82;81;82;104;81;81;104 19:44:33 INFO - PROCESS | 3757 | |5;imaging-gaussian-blur;117;117;117;116;116;116;116;117;117;117 19:44:33 INFO - PROCESS | 3757 | |6;imaging-darkroom;147;146;145;146;147;146;145;147;147;145 19:44:33 INFO - PROCESS | 3757 | |7;imaging-desaturate;94;95;95;94;95;94;94;95;95;95 19:44:33 INFO - PROCESS | 3757 | |8;json-parse-financial;51;53;51;53;51;51;50;49;50;50 19:44:33 INFO - PROCESS | 3757 | |9;json-stringify-tinderbox;59;60;58;58;60;59;59;59;59;58 19:44:33 INFO - PROCESS | 3757 | |10;stanford-crypto-aes;73;74;73;93;74;73;79;76;73;74 19:44:33 INFO - PROCESS | 3757 | |11;stanford-crypto-ccm;122;123;131;130;119;130;118;126;161;124 19:44:33 INFO - PROCESS | 3757 | |12;stanford-crypto-pbkdf2;153;151;153;155;153;157;151;157;155;150 19:44:33 INFO - PROCESS | 3757 | |13;stanford-crypto-sha256-iterative;63;62;62;62;61;61;63;62;61;61 19:44:33 INFO - PROCESS | 3757 | __end_tp_report 19:44:33 INFO - PROCESS | 3757 | __start_cc_report 19:44:33 INFO - PROCESS | 3757 | _x_x_mozilla_cycle_collect,1598 19:44:33 INFO - PROCESS | 3757 | __end_cc_report 19:44:33 INFO - PROCESS | 3757 | __startTimestamp1477363473158__endTimestamp 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | ------- Summary: start ------- 19:44:33 INFO - PROCESS | 3757 | Number of tests: 14 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.23 (1.1%) stddev-sans-first:1.22 19:44:33 INFO - PROCESS | 3757 | Values: 109.0 110.0 108.0 110.0 110.0 110.0 112.0 111.0 110.0 112.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:122.00 stddev:16.29 (13.4%) stddev-sans-first:16.06 19:44:33 INFO - PROCESS | 3757 | Values: 146.0 120.0 116.0 157.0 116.0 123.0 119.0 118.0 153.0 121.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 19:44:33 INFO - PROCESS | 3757 | Values: 161.0 163.0 160.0 160.0 161.0 160.0 159.0 161.0 161.0 160.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:13.58 (18.1%) stddev-sans-first:14.21 19:44:33 INFO - PROCESS | 3757 | Values: 75.0 76.0 77.0 114.0 75.0 74.0 75.0 74.0 98.0 75.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.00 stddev:14.17 (17.5%) stddev-sans-first:14.75 19:44:33 INFO - PROCESS | 3757 | Values: 82.0 81.0 120.0 82.0 81.0 82.0 104.0 81.0 81.0 104.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:44:33 INFO - PROCESS | 3757 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 19:44:33 INFO - PROCESS | 3757 | Values: 147.0 146.0 145.0 146.0 147.0 146.0 145.0 147.0 147.0 145.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:44:33 INFO - PROCESS | 3757 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.29 (2.5%) stddev-sans-first:1.36 19:44:33 INFO - PROCESS | 3757 | Values: 51.0 53.0 51.0 53.0 51.0 51.0 50.0 49.0 50.0 50.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 19:44:33 INFO - PROCESS | 3757 | Values: 59.0 60.0 58.0 58.0 60.0 59.0 59.0 59.0 59.0 58.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:74.00 stddev:6.20 (8.4%) stddev-sans-first:6.46 19:44:33 INFO - PROCESS | 3757 | Values: 73.0 74.0 73.0 93.0 74.0 73.0 79.0 76.0 73.0 74.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.00 stddev:12.32 (9.6%) stddev-sans-first:12.85 19:44:33 INFO - PROCESS | 3757 | Values: 122.0 123.0 131.0 130.0 119.0 130.0 118.0 126.0 161.0 124.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.00 stddev:2.46 (1.6%) stddev-sans-first:2.60 19:44:33 INFO - PROCESS | 3757 | Values: 153.0 151.0 153.0 155.0 153.0 157.0 151.0 157.0 155.0 150.0 19:44:33 INFO - PROCESS | 3757 | 19:44:33 INFO - PROCESS | 3757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 19:44:33 INFO - PROCESS | 3757 | Values: 63.0 62.0 62.0 62.0 61.0 61.0 63.0 62.0 61.0 61.0 19:44:33 INFO - PROCESS | 3757 | -------- Summary: end -------- 19:44:33 INFO - PROCESS | 3757 | 19:44:34 INFO - TEST-INFO | 3757: exit 0 19:44:34 INFO - TEST-OK | kraken | took 59792ms 19:44:34 INFO - SUITE-END | took 1173s 19:44:34 INFO - Completed test suite (00:19:34) 19:44:34 INFO - javascript benchmark 19:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.35110302388, 3209.9037028889134, 3225.3226822367287, 3253.951190732138, 3260.4131256373857, 5584.190292407604, 5663.546916246701, 5668.546516278698, 5683.175939488771, 5693.857653558658, 5654.0, 5699.772009119641, 5728.0, 5734.168545560891, 5750.856228594287, 5170.405403378612, 5199.168133098705, 5232.084385232569, 5244.239585260154, 5272.446393128724, 5059.519345662156, 5288.973555132219, 5309.30978972733, 5315.123004704219, 5345.278387417708, 5063.949360506403, 5064.113780088488, 5081.237814327862, 5087.338645976018, 5106.953074619712, 5119.283300337956, 5147.356580427447, 5160.664556803815, 5215.660982036194, 5223.764930578133, 5057.0, 5080.060188865034, 5179.61152913533, 5193.922091168635, 5219.582433405357, 5474.698891560963, 5520.889582208373, 5530.5022547970875, 5536.75084621193, 5581.972090139564, 5967.8209653710455, 5982.581219314649, 6077.632532680156, 6079.878402431971, 6090.512758979271, 6101.542384321194, 6110.663913484756, 6124.724387402578, 6126.356732543108, 6127.050307202391, 5478.04134276504, 5544.251526043973, 5556.194351818964, 5606.635568688022, 5719.456651618089, 6163.96918015416, 6182.969085154546, 6203.503719702413, 6211.65835879031, 6212.937870621236, 5962.34414214436, 5977.67122808241, 5982.521398288127, 5984.730687119003, 5987.670678112659, 5860.619059761102, 5928.762849485972, 5973.283206015219, 6013.007853704177, 6027.698615069229, 6074.54440916933, 6078.149059131725, 6080.14877917092, 6082.148499210114, 6106.938930610637, 6040.758369665252, 6091.543134264948, 6100.542459315569, 6102.633841969496, 6111.113888486145, 4557.931631025537, 4586.816527338936, 4595.287730401793, 4621.145088158702, 4663.48701642819, 4123.134141830249, 4143.81352839123, 4155.937660935088, 4161.188568229166, 4188.518320393194, 5742.942570574324, 5752.827415177551, 5753.309602847685, 5756.33802112754, 5759.136129580596, 5908.911366329508, 5975.940240597625, 6055.939440605625, 6108.816735497942, 6111.0, 5726.198332233491, 5824.155497452845, 5826.184334193216, 5852.736626851802, 5860.501857342174, 5319.654222475527, 5322.600804939645, 5333.866653333697, 5335.11970524859, 5340.465953404629, 6019.548533860066, 6053.061775424816, 6307.0, 6361.395667411589, 6387.584806987531, 6007.87984240304, 6107.480864126599, 6111.5110791137495, 6168.568200225941, 6169.321374648695, 6333.145025421693, 6339.270983836917, 6343.207099112611, 6345.302016778243, 6353.174087368612, 5742.253507044057, 6032.306284777132, 6033.78881739137, 6037.335893051673, 6037.969810150921, 5951.28584569837, 5969.044952807703, 6007.189029480965, 6025.78909738157, 6126.754929802758, 5896.528277737856, 5932.703364831655, 5938.257717785277, 5941.58408911372, 5949.0, 5941.197938278277, 5941.435563621449, 5950.851228719317, 5952.76188952437, 5956.106584012433, 5625.662460252398, 5766.3368712598585, 5837.270341207349, 5887.5289976802605, 5900.468957793819, 6041.969790151021, 6043.728032238472, 6046.848828779316, 6054.122152287806, 6054.697265136638, 5542.889142217214, 5879.118132280192, 5896.7936122235515, 5909.349971503218, 5910.290765108214], "value": 5591.5503230303975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5345000724424, 615.2709039787849, 615.7260019291415, 635.844218166549, 650.879587276354, 37946.241075178514, 38512.0, 46702.76648616752, 47351.763241183835, 47506.28740568894, 49505.75247123768, 49756.0, 49871.50128498714, 49921.0, 49955.25067123987, 9225.677101301455, 9410.0, 9413.199878010377, 9425.622975080989, 9426.717198484057, 8515.403921725481, 8755.956220218923, 10901.672949811518, 11146.888531114666, 11163.83254251187, 11331.0, 11405.37270450125, 11429.828552571718, 11437.085033197365, 11444.542218311299, 11096.500657470393, 11138.665840024812, 11166.050885674727, 11169.83245251322, 11211.66365009051, 11029.889701102966, 11110.555577776879, 11111.000009999058, 11115.944420277927, 11119.221654484189, 45975.080498390176, 46116.76941615304, 46124.0, 46135.077298454176, 46158.0, 3863.343231650626, 3893.669038131734, 3945.4649941541534, 4056.695747818896, 4092.7953602319767, 34215.14462138442, 34424.64083761282, 34472.389420315245, 34536.136596585035, 35066.6493335066, 4445.711028783118, 4449.065696203801, 4461.5092339842595, 4535.546445355471, 4603.746793926332, 374807.0, 375568.0, 376277.0, 378012.0, 378730.0, 65506.34493655098, 65516.34483655198, 65833.34166658368, 65834.67082664651, 65863.0, 40599.59400405958, 41709.58290417118, 41800.79099604482, 43870.0, 43898.0, 17516.0, 17637.82362176362, 17640.911795441196, 17644.735328970077, 17648.294068237385, 12219.877801222052, 12388.442520086617, 12403.689907752198, 12433.316167610868, 12474.625761227178, 18037.549061273574, 19702.901485492766, 20381.490462738253, 20462.590748184954, 21298.148074077173, 7584.848303033908, 7595.354394876387, 7759.495632783851, 7776.750693282012, 7935.64289606969, 1021.5658345203259, 1076.967690969272, 1092.3937214845678, 1123.1351859068634, 1162.9302241865514, 35192.824035879654, 35237.82381088078, 35654.28691426209, 35687.64312356895, 35742.74900378526, 1140.4126874659557, 1145.833854091152, 1173.4602083041725, 1187.2105050141558, 1195.1036722458157, 18477.445676629453, 18510.722339164924, 18580.349687760863, 18606.81393186078, 18610.44168674942, 590280.0, 595304.0, 596527.0, 596538.0, 597181.0, 63624.68187659032, 64006.0, 64343.0, 64370.35629643737, 64384.0, 1319.8680131986916, 1369.8561651026498, 1432.3196481671332, 1445.8915581331441, 1476.8080149580485, 32152.678473214968, 35643.64356356403, 35843.28313433769, 35966.0, 36357.81821090878, 56468.0, 56938.430615693316, 57277.713611431675, 57316.42683573111, 57320.71339643275, 410704.0, 411885.0, 412390.0, 415286.0, 415524.0, 31325.68674313319, 31411.528827067155, 31874.20314492156, 32301.192470187492, 33843.323133537684, 51485.7425712884, 51564.0, 52102.0, 52377.214341785664, 53127.0, 43274.567254328314, 43473.78263108791, 44038.0, 44166.0, 45028.549714502435, 42192.854620422884, 43944.0, 44176.77911610421, 44613.0, 45811.083778324915, 39980.800575982765, 44417.0, 44612.55387446084, 45471.772641137904, 45474.772626136655, 35883.461748074325, 38273.808630956664, 39237.607623923395, 39331.2133757329, 39390.606093938695, 29376.531173440813, 29773.702262977095, 29893.850530747208, 30154.396912062075, 30194.69805301919], "value": 21615.62050038613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.125725290241, 410.1223381962599, 423.9745615263083, 425.7296616648428, 432.3752178102641, 14703.632409189762, 16402.179891005446, 20253.898730506346, 20878.582428351423, 21243.6813447798, 19200.903995480003, 19617.215311387565, 19669.704954425695, 20137.59724805503, 20767.169313227452, 5863.208466856983, 5928.703564821763, 6015.0676645120075, 6040.822039702238, 6061.060535616986, 5979.581429299951, 6073.574849760518, 6074.605150665215, 6078.422549857756, 6081.361457047013, 4217.557156498569, 4443.688941774077, 4542.750148741818, 6674.899876501856, 6754.358335958076, 6684.398404143651, 6726.966365168192, 6797.660116994155, 6818.045473633695, 6838.487113466485, 5991.221141251653, 6016.2479690038745, 6026.0960855871535, 6030.366811484819, 6041.365656606081, 23828.64257036146, 24358.39104022396, 24435.63346549803, 24566.877165614056, 24726.258212253662, 2550.13295479536, 2628.6451329070524, 2630.0, 2754.724527547249, 2986.522156454957, 15364.923175384052, 15509.5347139586, 15519.3016314265, 15536.844631553766, 15809.60475988098, 1983.3256692724399, 2073.6889466579983, 2093.0685844799073, 2144.3352560706076, 2228.275810361639, 85655.57172214099, 88377.11622883753, 89235.55382223113, 89265.0, 89409.0, 11170.664880053611, 11203.831942520868, 11241.550337986553, 11496.655100347003, 11808.228765685044, 16286.26711797972, 16308.673826523403, 16316.592085197728, 16324.836751632569, 16347.754783678254, 9005.459672419676, 9027.864582031143, 9193.080691930754, 9222.584983675752, 9351.579178936965, 9140.771480713036, 9165.541722913827, 9207.217386522087, 9322.114399132071, 9397.483138427453, 6723.630200339028, 6806.93193068063, 6830.180378354629, 6880.208775990725, 6936.410405115622, 1930.4112245764895, 2068.841448788683, 2086.1759604955955, 2101.2750601042617, 2121.9257325993517, 809.6316176139842, 958.5878072428923, 983.2871168402851, 1059.7933402986498, 1090.7872964771952, 12810.743785124245, 13585.116967397087, 20432.693509597368, 21552.168065714275, 21579.028943697256, 500.4495055438988, 509.3792437906948, 515.0702981119041, 517.4747631154381, 518.6058595467397, 6787.830304242433, 7212.567245965259, 7278.526895751759, 7290.9635451822405, 7366.226546212678, 465338.0, 479358.0, 479921.0, 486279.0, 520519.0, 97291.0, 98638.0, 99146.0, 101084.0, 101327.4933625342, 517.6247220764915, 526.9156934890399, 527.5911168844176, 528.3501293409129, 529.3594750352117, 12165.635030949086, 12210.938945305217, 12383.318917459626, 12513.436895339913, 12556.811647825472, 43820.56179438165, 44611.10777784491, 45282.547174527834, 45488.54511454843, 46395.304070438295, 61062.084068739896, 61853.0, 62478.687606561674, 62560.0, 63653.363466364746, 9208.447493150432, 9285.164335209864, 9296.628134874529, 9314.394564353295, 9387.436753794795, 13089.214647121204, 13164.868351316747, 13327.333633318489, 13766.31168441594, 13996.930015349859, 10921.470994060679, 11558.248713833911, 11927.76144477123, 12170.208936419105, 12453.003759699384, 11798.469068891749, 12089.032877369613, 12153.331566763913, 12153.635390938285, 12443.626691199279, 11820.40897955116, 11979.221350612183, 12171.14801963854, 12748.4263208154, 12983.935080324538, 9282.860757088514, 9453.952730236304, 9488.762780930532, 9604.279679024241, 9742.31803773729, 11995.520179192734, 12459.12786104964, 12531.436085375997, 12718.554850580185, 12872.292023938773], "value": 9319.574914683673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.292845291166, 1562.9218539073047, 1713.6315692126198, 1830.0575203770052, 1843.7879643840963, 9109.271258299337, 9823.410595364274, 9838.60645574178, 9840.360376575518, 9852.556634951427, 8012.439129260954, 8257.463264887778, 8266.50400975942, 8507.319414446845, 9570.904290957089, 2466.457379376539, 2567.4479986802835, 2573.7040240372316, 2587.081586036958, 2590.8575028373434, 2542.8855701493385, 2572.4726431081676, 2608.660874086366, 2636.6440530528325, 2640.551106311922, 2522.735112813156, 2533.138732830837, 2533.278015765507, 2548.566743653583, 2609.0346571768378, 2500.949981000379, 2510.4853505031515, 2512.271441282044, 2514.823962322638, 2515.8490490570443, 2525.1414519063605, 2528.5575024370846, 2529.45616692412, 2558.6162075688794, 2560.2319304208663, 9589.664361747375, 9674.951625241829, 9676.371035882716, 9690.70927872165, 9691.70924872255, 5645.717714114277, 5901.527877769769, 5903.675297858616, 5907.0, 5911.793087241969, 3472.2187507810795, 3579.069441945087, 3655.4882316475714, 3660.652238037382, 3660.8535658573624, 1166.9264276865304, 1188.144535934126, 1209.6129238643637, 1223.5350566784655, 1225.6078055022397, 13536.796948045787, 13595.04834661574, 13622.0, 13650.180989140585, 13650.590482285448, 5118.61610379223, 5235.424103348705, 5326.280952071498, 5335.11970524859, 5414.729263536808, 11469.369184694922, 11473.196876218584, 11504.712382190512, 11526.135539834546, 11536.365499897418, 5942.554308426886, 5984.401559843981, 5990.281166260077, 5995.250593675791, 5997.580169388189, 5323.893522129613, 5340.012097761926, 5395.2986111806, 5460.044492213847, 5474.0, 4255.6169944705125, 4389.209942210433, 4457.576530229623, 4543.931841022388, 4545.36364908913, 1430.4206796247536, 1462.2396353895915, 1468.6695493514087, 1470.3897882378908, 1471.0438215160232, 964.3538828984597, 1000.9949950250348, 1008.6318493749875, 1024.948752562369, 1030.2891005206384, 6277.372262773686, 6461.709223084972, 6492.188476440445, 6519.576227545194, 6671.933280667228, 521.1687358662926, 521.8904030153634, 524.8241838983906, 536.2037374498866, 538.4292649791233, 4188.643965262926, 4343.326784348431, 4438.289873620205, 4566.178087944202, 4568.132054909623, 11332.150088743378, 11953.282803031845, 11954.58158964432, 11956.163068585116, 11970.940145299217, 11242.66272011841, 11888.940555297168, 11924.344161071225, 11946.820797688042, 11948.701282467833, 8629.956850215834, 9015.594298256594, 9025.277977761763, 9048.728538143867, 9055.094490551024, 6562.901556476752, 6600.768973085919, 6641.402273795382, 6732.899006514808, 6837.521373504006, 10455.581776728846, 11238.606648767254, 11247.381394023407, 11312.03847672957, 11408.429578521207, 9909.355891867293, 11037.061849742862, 11130.109591232844, 11276.154288428237, 11280.548778049115, 7475.887861682188, 7928.881066784118, 8167.1424500428975, 8220.684690449738, 8389.496630202208, 9205.76985575366, 9221.49281789508, 9319.207867331354, 9374.484403357881, 9409.623615055321, 7976.561289129154, 8046.476978996347, 8194.057683366489, 8208.261256486707, 8373.665053397795, 7983.680652774056, 8109.959450202711, 8148.877766833621, 8253.95873020631, 8284.875726864222, 7375.704971801068, 7481.588512631857, 7484.32641062307, 7490.962545187239, 7503.062117235346, 5357.089294819968, 5440.183972404171, 5469.535089517276, 5487.286652735279, 5677.829665110054, 5530.115181570929, 5560.5829562783765, 5612.494875461228, 5728.942710573007, 5790.565707571865], "value": 4967.50321036201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.43915016398665, 354.2419222863073, 354.88998410492746, 355.87366484897854, 358.81162389745396, 5561.443855614437, 5592.328920529532, 5600.775968961237, 5605.691686957216, 5647.717614119299, 5491.917621235684, 5498.505134537891, 5505.779768809243, 5517.944820551793, 5531.944680553203, 3870.3807390817474, 4098.01647604575, 4192.601702838241, 4300.78496075195, 4390.582894625006, 4359.3025115981445, 4363.956360436403, 4370.453693288339, 4383.780810959455, 4387.736735795863, 4335.371371151181, 4364.410804541394, 4397.230484665187, 4404.713693609921, 4407.823687052514, 4077.607672016352, 4171.144915292358, 4360.56394360563, 4394.956345299419, 4424.358468022151, 3870.9612903870884, 3891.727579069466, 3907.1404291055924, 3939.763614183158, 3941.2905676978135, 5354.4125435958, 5385.946140538584, 5396.514313711785, 5398.460153984609, 5457.808976685797, 4704.741239231841, 4947.282644016597, 4988.501149885019, 5042.571381432546, 5064.265681476165, 5699.401562835926, 5710.828675139711, 5716.514096301819, 5742.971285143548, 5759.68321742304, 4229.281022226198, 4239.215745087169, 4243.745375277494, 4244.978775106136, 4249.810053185113, 5759.539236861041, 5906.26171728534, 5940.673262970535, 5965.522758179335, 6057.394260573951, 4274.829006839754, 4280.850170244026, 4297.871063868089, 4301.634361079344, 4314.848980285675, 4358.978205109018, 4362.323839804835, 4365.847195348148, 4367.825286988485, 4410.823567057346, 4763.404574428197, 4973.850784476399, 5002.924956125661, 5017.172166592544, 5020.66952257652, 5753.899826563358, 5795.507381872504, 5827.213326200994, 5831.912521312183, 5838.357780644125, 1495.424261659269, 1510.4562357551272, 1511.8866085043667, 1514.8257950335853, 1514.9318280677176, 973.5667627905656, 990.2770977186694, 991.6083147156977, 1036.1658864614058, 1059.5179193466954, 5506.1190209566275, 5514.862128446741, 5528.474794894479, 5536.280283563111, 5540.141278101901, 5894.233749612523, 5898.262717160355, 5930.71667408051, 5930.8813823723285, 5952.375000624872, 5350.117230656898, 5578.972105139448, 5622.32532096151, 5633.155026746021, 5661.405552417019, 3147.779655424144, 3177.7616678749187, 3187.5815262208093, 3196.0, 3198.792078514936, 5955.017422125387, 6156.445919867234, 6165.70520190756, 6171.691415429211, 6183.876322473526, 5844.678542680108, 6144.907826382608, 6155.907661385083, 6162.291336496271, 6171.13604095427, 6050.788222412194, 6085.300190478063, 6088.817335479854, 6178.351273116348, 6178.752849885954, 5938.317093534126, 5961.463468287875, 5967.0, 5980.312264089685, 5987.820365389045, 5626.662400255997, 5903.91144132847, 5921.733521991435, 5962.880742385215, 5965.403459654173, 6183.96908015457, 6195.597286176384, 6195.690215489298, 6202.805555139017, 6214.9067763982675, 4120.670346372223, 4331.328644060176, 4334.068175342317, 4363.4981977071775, 4382.956170438255, 5945.672987985529, 5948.464638182584, 5950.940490595039, 5955.5235581154275, 5974.40255974399, 5827.125931110368, 5847.0, 5850.0932355484965, 5857.690404921206, 5857.912131318119, 5675.375708671961, 5775.48020678141, 5777.62445441045, 5819.621724587888, 5826.679532625577, 5692.6299790513485, 5727.8568035799435, 5729.942700573108, 5745.569082318759, 5760.884782304414, 5630.887382252414, 5777.3933736957015, 5797.59416840834, 5806.44838740319, 5836.941630583639, 5680.744366503434, 5685.971570142123, 5698.629589076697, 5699.373068962328, 5711.200431939615], "value": 4449.709271510467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.203838200182, 820.0, 836.431226765799, 842.8651415773477, 898.9775255618605, 16196.838031619694, 17810.64378712428, 18014.81985180148, 18070.09649517524, 18096.54758631033, 16207.108609026498, 16260.0, 16271.51185464435, 16440.588985275375, 16448.67102657946, 823.7652269103306, 846.932245420368, 849.7026040885702, 849.7408290471403, 851.9190676885686, 700.898369736388, 729.1833146875507, 805.0982899152928, 850.2857599616322, 855.4396870050127, 903.56628818167, 906.4697152165991, 906.9637214511412, 908.1191244492832, 909.1499448016126, 903.7966457547033, 905.1898550797, 905.714699869539, 906.0441234497636, 906.3202598051462, 531.346443874037, 553.1371061144587, 623.0622912516678, 653.6470306034736, 659.0443856408227, 15431.691366172727, 15491.922540387339, 15511.5346539604, 15541.378344866192, 15560.533184004498, 14969.850301496954, 15471.922640386838, 15552.0, 15597.298121584556, 15725.213739312989, 14066.2966851657, 14196.361163747657, 14225.573232803032, 14236.359363828653, 14299.856011519054, 4723.574878260973, 4769.976150119262, 4772.188727916227, 4785.641076919245, 4851.151048566487, 88001.55999219963, 90220.54889725575, 91664.99999999933, 92308.07691923062, 92577.537112314, 11491.42542872853, 11755.412229388667, 11773.411329433495, 11844.348560829238, 12086.39568021613, 22265.332040038826, 22295.442613934458, 22297.442563935707, 22335.0, 22350.441238969157, 8717.215450609476, 8809.867851982226, 8838.425502342327, 8906.287497000225, 9220.354575179806, 5121.4878512149235, 5124.180131178993, 5196.714180720097, 5329.840104796862, 5339.41266460689, 3730.645588669072, 3820.84716611338, 3845.442410850467, 3852.8844134676006, 3853.5183102112237, 612.3723183736705, 622.6979914741347, 668.6055227415848, 699.101654374137, 714.4213187318185, 656.7635651165576, 745.198911170483, 752.4319139049982, 760.1410406240913, 780.434185215714, 10352.689419317432, 10536.525856336484, 10554.841677374845, 10569.682909512727, 10683.893161068445, 677.5732180270134, 687.4328678839977, 691.4330249195611, 774.9263819937097, 805.4965646470955, 5013.24801279811, 5242.397124330674, 5281.419043905167, 5305.602079844027, 5316.149416093406, 109099.45450272698, 109525.0, 113160.0, 120164.39917800356, 133695.33152334372, 106543.84974085508, 107305.46347268214, 109487.0, 110854.44572777246, 113001.4349928245, 92333.53833230791, 94180.52909735407, 94298.5285073584, 95421.5228923851, 96357.0, 10632.096271816983, 10801.837972430263, 10969.451527423438, 11074.778504430027, 11175.38535380562, 50436.0, 51138.74430627823, 51448.22827657513, 53826.46173538371, 54945.0, 72241.6387918057, 72260.0, 80240.0, 80626.59686701764, 82401.58799205965, 13438.260895650443, 13678.52125175654, 13723.451061957809, 13828.723425531232, 13932.93033534826, 14933.253337333308, 15006.006589802222, 15136.924315378352, 15315.081095134328, 15559.922200388926, 11755.706107347385, 14765.630859228606, 15745.606359841096, 15958.0, 15996.280167392262, 14093.683526792724, 14757.188354640597, 14770.33533490974, 14836.851631483547, 14975.1014939104, 12915.354232288535, 13092.541761038317, 13095.476180952655, 13369.331533423485, 13626.386812593655, 12047.397630118634, 12790.36048197605, 12988.610341689764, 13159.407826647632, 13323.200607963554, 12677.87322126767, 12818.74362512726, 12846.871531284567, 12892.162009469355, 13072.803907941197], "value": 8132.4588042593, "unit": "score"}], "name": "dromaeo_css", "value": 7663.11028370995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 108.0, 110.0, 110.0, 110.0, 112.0, 111.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 116.0, 157.0, 116.0, 123.0, 119.0, 118.0, 153.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 160.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 114.0, 75.0, 74.0, 75.0, 74.0, 98.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 120.0, 82.0, 81.0, 82.0, 104.0, 81.0, 81.0, 104.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 147.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 53.0, 51.0, 51.0, 50.0, 49.0, 50.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 93.0, 74.0, 73.0, 79.0, 76.0, 73.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 131.0, 130.0, 119.0, 130.0, 118.0, 126.0, 161.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 153.0, 155.0, 153.0, 157.0, 151.0, 157.0, 155.0, 150.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1457.8000000000002, "alertThreshold": 2.0}]} 19:44:34 INFO - Return code: 0 19:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:34 INFO - # TBPL SUCCESS # 19:44:34 INFO - Running post-action listener: _resource_record_post_action 19:44:34 INFO - [mozharness: 2016-10-25 02:44:34.996694Z] Finished run-tests step (success) 19:44:34 INFO - Running post-run listener: _resource_record_post_run 19:44:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358371328; Read time: 8; Write time: 267560 19:44:35 INFO - TinderboxPrint: CPU usage
12.9% 19:44:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:44:35 INFO - TinderboxPrint: I/O write bytes / time
358,371,328 / 267,560 19:44:35 INFO - TinderboxPrint: CPU idle
8,271.6 (87.1%) 19:44:35 INFO - TinderboxPrint: CPU user
1,182.7 (12.5%) 19:44:35 INFO - TinderboxPrint: Swap in / out
0 / 0 19:44:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108179456; Read time: 0; Write time: 105376 19:44:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249716736; Read time: 0; Write time: 162176 19:44:35 INFO - Running post-run listener: _upload_blobber_files 19:44:35 INFO - Blob upload gear active. 19:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:35 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 19:44:35 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'] 19:44:35 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 19:44:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:36 INFO - (blobuploader) - INFO - Done attempting. 19:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:37 INFO - (blobuploader) - INFO - Done attempting. 19:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:40 INFO - (blobuploader) - INFO - Done attempting. 19:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:44:40 INFO - Return code: 0 19:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dc529e20d8dcd31997709b382709f08429172bac2e0b0debc72c3a5b1aab7fd4b504185ee90e05d9d42ed7cac7cabd44aa043ddb11c5a7b8fa135f709e30d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/435b7c0a40a19d1d47567667904b95098aeadc91a5f08d123f2c39dec8a34c7c33ab2068b7f7655662d17340a5a13bc244bac13f9fd463271ff87fba320b46e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57b835d99f0202230cdde3ac67ed196517f96114c79c638cf6183ab260395f63eaa6a720f796131dbf368e2cee2303ea2249e0f084fede9d422a9437a1ba24ca"} 19:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:44:40 INFO - Contents: 19:44:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dc529e20d8dcd31997709b382709f08429172bac2e0b0debc72c3a5b1aab7fd4b504185ee90e05d9d42ed7cac7cabd44aa043ddb11c5a7b8fa135f709e30d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/435b7c0a40a19d1d47567667904b95098aeadc91a5f08d123f2c39dec8a34c7c33ab2068b7f7655662d17340a5a13bc244bac13f9fd463271ff87fba320b46e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57b835d99f0202230cdde3ac67ed196517f96114c79c638cf6183ab260395f63eaa6a720f796131dbf368e2cee2303ea2249e0f084fede9d422a9437a1ba24ca"} 19:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:44:40 INFO - Copying logs to upload dir... 19:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.602173 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-24 19:44:40.645621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:44:40.649027) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 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/8dc529e20d8dcd31997709b382709f08429172bac2e0b0debc72c3a5b1aab7fd4b504185ee90e05d9d42ed7cac7cabd44aa043ddb11c5a7b8fa135f709e30d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/435b7c0a40a19d1d47567667904b95098aeadc91a5f08d123f2c39dec8a34c7c33ab2068b7f7655662d17340a5a13bc244bac13f9fd463271ff87fba320b46e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57b835d99f0202230cdde3ac67ed196517f96114c79c638cf6183ab260395f63eaa6a720f796131dbf368e2cee2303ea2249e0f084fede9d422a9437a1ba24ca"} build_url:https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/NWYsh3xgQPGH3FtNffAM9A/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/8dc529e20d8dcd31997709b382709f08429172bac2e0b0debc72c3a5b1aab7fd4b504185ee90e05d9d42ed7cac7cabd44aa043ddb11c5a7b8fa135f709e30d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/435b7c0a40a19d1d47567667904b95098aeadc91a5f08d123f2c39dec8a34c7c33ab2068b7f7655662d17340a5a13bc244bac13f9fd463271ff87fba320b46e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57b835d99f0202230cdde3ac67ed196517f96114c79c638cf6183ab260395f63eaa6a720f796131dbf368e2cee2303ea2249e0f084fede9d422a9437a1ba24ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:44:40.677100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:44:40.677608) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477362246.401841-2023323182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:44:40.760289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:44:40.760610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:44:40.760893) ========= ========= Total master_lag: 0.17 =========