builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1481789093.42 results: success (0) buildid: 20161214223004 builduid: e7381a4ca44546f88b8b3ac924379fac revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.420249) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.420820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.421105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.436849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.437174) ========= 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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 00:04:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-12-15 00:04:53 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.538527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.538845) ========= 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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020206 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.588393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:53.588753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 00:04:53,684 truncating revision to first 12 chars 2016-12-15 00:04:53,684 Setting DEBUG logging. 2016-12-15 00:04:53,684 attempt 1/10 2016-12-15 00:04:53,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7652a58efa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 00:04:53,999 unpacking tar archive at: mozilla-central-7652a58efa46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:54.228737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:54.229068) ========= script_repo_revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:54.229467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:54.229761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 00:04:54.240370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-15 00:04:54.240865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:04:54 INFO - MultiFileLogger online at 20161215 00:04:54 in /builds/slave/test 00:04:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:04:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:54 INFO - {'append_to_log': False, 00:04:54 INFO - 'base_work_dir': '/builds/slave/test', 00:04:54 INFO - 'blob_upload_branch': 'Firefox', 00:04:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:54 INFO - 'branch': 'Firefox', 00:04:54 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:54 INFO - 'config_files': ('talos/linux_config.py',), 00:04:54 INFO - 'default_actions': ('clobber', 00:04:54 INFO - 'read-buildbot-config', 00:04:54 INFO - 'download-and-extract', 00:04:54 INFO - 'populate-webroot', 00:04:54 INFO - 'create-virtualenv', 00:04:54 INFO - 'install', 00:04:54 INFO - 'run-tests'), 00:04:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:54 INFO - 'download_minidump_stackwalk': True, 00:04:54 INFO - 'download_symbols': 'ondemand', 00:04:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:04:54 INFO - 'tooltool.py': '/tools/tooltool.py', 00:04:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:04:54 INFO - '/tools/misc-python/virtualenv.py')}, 00:04:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:54 INFO - 'installer_path': 'installer.exe', 00:04:54 INFO - 'log_level': 'info', 00:04:54 INFO - 'log_name': 'talos', 00:04:54 INFO - 'log_to_console': True, 00:04:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:04:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:04:54 INFO - 'opt_config_files': (), 00:04:54 INFO - 'pip_index': False, 00:04:54 INFO - 'sps_profile': False, 00:04:54 INFO - 'sps_profile_interval': 0, 00:04:54 INFO - 'suite': 'dromaeojs', 00:04:54 INFO - 'system_bits': '32', 00:04:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:54 INFO - 'title': 'talos-linux64-ix-024', 00:04:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:54 INFO - 'use_talos_json': True, 00:04:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:54 INFO - 'work_dir': 'build'} 00:04:54 INFO - [mozharness: 2016-12-15 08:04:54.434569Z] Running clobber step. 00:04:54 INFO - Running pre-action listener: _resource_record_pre_action 00:04:54 INFO - Running main action method: clobber 00:04:54 INFO - rmtree: /builds/slave/test/build 00:04:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:55 INFO - Running post-action listener: _resource_record_post_action 00:04:55 INFO - [mozharness: 2016-12-15 08:04:55.406519Z] Finished clobber step (success) 00:04:55 INFO - [mozharness: 2016-12-15 08:04:55.406620Z] Running read-buildbot-config step. 00:04:55 INFO - Running pre-action listener: _resource_record_pre_action 00:04:55 INFO - Running main action method: read_buildbot_config 00:04:55 INFO - Using buildbot properties: 00:04:55 INFO - { 00:04:55 INFO - "project": "", 00:04:55 INFO - "product": "firefox", 00:04:55 INFO - "script_repo_revision": "production", 00:04:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:04:55 INFO - "repository": "", 00:04:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 00:04:55 INFO - "buildid": "20161214223004", 00:04:55 INFO - "pgo_build": "True", 00:04:55 INFO - "basedir": "/builds/slave/test", 00:04:55 INFO - "buildnumber": 112, 00:04:55 INFO - "slavename": "talos-linux64-ix-024", 00:04:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:04:55 INFO - "platform": "ubuntu64_hw", 00:04:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:04:55 INFO - "branch": "mozilla-central", 00:04:55 INFO - "repo_path": "mozilla-central", 00:04:55 INFO - "revision": "7652a58efa46f1c57c94bba26efc5d53b6184e83", 00:04:55 INFO - "stage_platform": "linux64-pgo", 00:04:55 INFO - "builduid": "e7381a4ca44546f88b8b3ac924379fac", 00:04:55 INFO - "slavebuilddir": "test" 00:04:55 INFO - } 00:04:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 00:04:55 INFO - Running post-action listener: _resource_record_post_action 00:04:55 INFO - [mozharness: 2016-12-15 08:04:55.409119Z] Finished read-buildbot-config step (success) 00:04:55 INFO - [mozharness: 2016-12-15 08:04:55.409208Z] Running download-and-extract step. 00:04:55 INFO - Running pre-action listener: _resource_record_pre_action 00:04:55 INFO - Running main action method: download_and_extract 00:04:55 INFO - mkdir: /builds/slave/test/build/tests 00:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:55 INFO - trying https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - Downloading https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:04:55 INFO - Downloaded 1361 bytes. 00:04:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - Using the following test package requirements: 00:04:55 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:04:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:04:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:04:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'jsshell-linux-x86_64.zip'], 00:04:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:04:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:04:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:04:55 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:04:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:04:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:04:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:04:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:04:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:04:55 INFO - Fetch https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:04:56 INFO - Expected file size: 21774438 00:04:56 INFO - Obtained file size: 21774438 00:05:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:05:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:05:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:05:00 INFO - Fetch https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:05:01 INFO - Expected file size: 21774438 00:05:01 INFO - Obtained file size: 21774438 00:05:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 00:05:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:05:06 INFO - Fetch https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:05:07 INFO - Expected file size: 14409734 00:05:07 INFO - Obtained file size: 14409734 00:05:07 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')]} 00:05:07 INFO - trying https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:05:07 INFO - Downloading https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:05:10 INFO - Downloaded 59903198 bytes. 00:05:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:05:10 INFO - mkdir: /builds/slave/test/properties 00:05:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:05:10 INFO - Writing to file /builds/slave/test/properties/build_url 00:05:10 INFO - Contents: 00:05:10 INFO - build_url:https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:05:10 INFO - Running post-action listener: _resource_record_post_action 00:05:10 INFO - Running post-action listener: set_extra_try_arguments 00:05:10 INFO - [mozharness: 2016-12-15 08:05:10.903869Z] Finished download-and-extract step (success) 00:05:10 INFO - [mozharness: 2016-12-15 08:05:10.904096Z] Running populate-webroot step. 00:05:10 INFO - Running pre-action listener: _resource_record_pre_action 00:05:10 INFO - Running main action method: populate_webroot 00:05:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:05:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:05:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:05:10 INFO - '--tppagecycles', 00:05:10 INFO - '7'], 00:05:10 INFO - 'tests': ['tsvgm']}}, 00:05:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:05:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:05:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:05:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:05:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['damp', 'tps']}, 00:05:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'tests': ['damp', 'tps']}, 00:05:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['dromaeo_dom']}, 00:05:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:05:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['basic_compositor_video']}, 00:05:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:05:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'other-e10s': {'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['a11yr', 00:05:10 INFO - 'ts_paint', 00:05:10 INFO - 'tpaint', 00:05:10 INFO - 'sessionrestore', 00:05:10 INFO - 'sessionrestore_no_auto_restore', 00:05:10 INFO - 'tabpaint']}, 00:05:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['tsvgx', 00:05:10 INFO - 'tsvgr_opacity', 00:05:10 INFO - 'tart', 00:05:10 INFO - 'tscrollx', 00:05:10 INFO - 'cart', 00:05:10 INFO - 'tsvg_static']}, 00:05:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:05:10 INFO - 'tsvgr_opacity', 00:05:10 INFO - 'tart', 00:05:10 INFO - 'tscrollx', 00:05:10 INFO - 'cart', 00:05:10 INFO - 'tsvg_static']}, 00:05:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'talos_options': ['--disable-e10s'], 00:05:10 INFO - 'tests': ['tp5o']}, 00:05:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:05:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'talos_options': ['--disable-e10s', 00:05:10 INFO - '--xperf_path', 00:05:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:10 INFO - 'tests': ['tp5n']}, 00:05:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:05:10 INFO - 'talos_options': ['--xperf_path', 00:05:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:10 INFO - 'tests': ['tp5n']}}, 00:05:10 INFO - 'talos.zip': {'path': '', 00:05:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:05:10 INFO - Running post-action listener: _resource_record_post_action 00:05:10 INFO - [mozharness: 2016-12-15 08:05:10.925661Z] Finished populate-webroot step (success) 00:05:10 INFO - [mozharness: 2016-12-15 08:05:10.925750Z] Running create-virtualenv step. 00:05:10 INFO - Running pre-action listener: _resource_record_pre_action 00:05:10 INFO - Running main action method: create_virtualenv 00:05:10 INFO - Creating virtualenv /builds/slave/test/build/venv 00:05:10 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 00:05:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:05:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:05:11 INFO - Using real prefix '/usr' 00:05:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:05:11 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:13 INFO - Installing pip.................done. 00:05:13 INFO - Return code: 0 00:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:05:13 INFO - Reading from file tmpfile_stdout 00:05:13 INFO - Output received: 00:05:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:05:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:13 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')]} 00:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:13 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')]} 00:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:13 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:13 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 00:05:13 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 00:05:13 INFO - Using env: {'DISPLAY': ':0', 00:05:13 INFO - 'HOME': '/home/cltbld', 00:05:13 INFO - 'LANG': 'en_US.UTF-8', 00:05:13 INFO - 'LANGUAGE': 'en_US:en', 00:05:13 INFO - 'LOGNAME': 'cltbld', 00:05:13 INFO - 'MAIL': '/var/mail/cltbld', 00:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:13 INFO - 'MOZ_NO_REMOTE': '1', 00:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:13 INFO - 'NO_EM_RESTART': '1', 00:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:13 INFO - 'PWD': '/builds/slave/test', 00:05:13 INFO - 'SHELL': '/bin/bash', 00:05:13 INFO - 'SHLVL': '1', 00:05:13 INFO - 'TERM': 'linux', 00:05:13 INFO - 'TMOUT': '86400', 00:05:13 INFO - 'USER': 'cltbld', 00:05:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:13 INFO - '_': '/tools/buildbot/bin/python'} 00:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:13 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 00:05:13 INFO - Cleaning up... 00:05:13 INFO - Return code: 0 00:05:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:05:13 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')]} 00:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:13 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')]} 00:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:13 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:13 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 00:05:13 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 00:05:13 INFO - Using env: {'DISPLAY': ':0', 00:05:13 INFO - 'HOME': '/home/cltbld', 00:05:13 INFO - 'LANG': 'en_US.UTF-8', 00:05:13 INFO - 'LANGUAGE': 'en_US:en', 00:05:13 INFO - 'LOGNAME': 'cltbld', 00:05:13 INFO - 'MAIL': '/var/mail/cltbld', 00:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:13 INFO - 'MOZ_NO_REMOTE': '1', 00:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:13 INFO - 'NO_EM_RESTART': '1', 00:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:13 INFO - 'PWD': '/builds/slave/test', 00:05:13 INFO - 'SHELL': '/bin/bash', 00:05:13 INFO - 'SHLVL': '1', 00:05:13 INFO - 'TERM': 'linux', 00:05:13 INFO - 'TMOUT': '86400', 00:05:13 INFO - 'USER': 'cltbld', 00:05:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:13 INFO - '_': '/tools/buildbot/bin/python'} 00:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:14 INFO - Downloading/unpacking psutil>=3.1.1 00:05:14 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 00:05:14 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 00:05:14 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 00:05:14 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 00:05:14 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 00:05:14 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 00:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:16 INFO - Installing collected packages: psutil 00:05:16 INFO - Running setup.py install for psutil 00:05:16 INFO - building 'psutil._psutil_linux' extension 00:05:16 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 00:05:16 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 00:05:16 INFO - building 'psutil._psutil_posix' extension 00:05:16 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 00:05:16 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 00:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:16 INFO - Successfully installed psutil 00:05:16 INFO - Cleaning up... 00:05:16 INFO - Return code: 0 00:05:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:05:16 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')]} 00:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:16 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')]} 00:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:17 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:17 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 00:05:17 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 00:05:17 INFO - Using env: {'DISPLAY': ':0', 00:05:17 INFO - 'HOME': '/home/cltbld', 00:05:17 INFO - 'LANG': 'en_US.UTF-8', 00:05:17 INFO - 'LANGUAGE': 'en_US:en', 00:05:17 INFO - 'LOGNAME': 'cltbld', 00:05:17 INFO - 'MAIL': '/var/mail/cltbld', 00:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:17 INFO - 'MOZ_NO_REMOTE': '1', 00:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:17 INFO - 'NO_EM_RESTART': '1', 00:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:17 INFO - 'PWD': '/builds/slave/test', 00:05:17 INFO - 'SHELL': '/bin/bash', 00:05:17 INFO - 'SHLVL': '1', 00:05:17 INFO - 'TERM': 'linux', 00:05:17 INFO - 'TMOUT': '86400', 00:05:17 INFO - 'USER': 'cltbld', 00:05:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:17 INFO - '_': '/tools/buildbot/bin/python'} 00:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:05:17 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 00:05:17 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 00:05:17 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 00:05:17 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 00:05:17 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 00:05:17 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 00:05:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:05:19 INFO - Installing collected packages: mozsystemmonitor 00:05:19 INFO - Running setup.py install for mozsystemmonitor 00:05:19 INFO - Successfully installed mozsystemmonitor 00:05:19 INFO - Cleaning up... 00:05:19 INFO - Return code: 0 00:05:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:05:19 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')]} 00:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:19 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')]} 00:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:19 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:19 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 00:05:19 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 00:05:19 INFO - Using env: {'DISPLAY': ':0', 00:05:19 INFO - 'HOME': '/home/cltbld', 00:05:19 INFO - 'LANG': 'en_US.UTF-8', 00:05:19 INFO - 'LANGUAGE': 'en_US:en', 00:05:19 INFO - 'LOGNAME': 'cltbld', 00:05:19 INFO - 'MAIL': '/var/mail/cltbld', 00:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:19 INFO - 'MOZ_NO_REMOTE': '1', 00:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:19 INFO - 'NO_EM_RESTART': '1', 00:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:19 INFO - 'PWD': '/builds/slave/test', 00:05:19 INFO - 'SHELL': '/bin/bash', 00:05:19 INFO - 'SHLVL': '1', 00:05:19 INFO - 'TERM': 'linux', 00:05:19 INFO - 'TMOUT': '86400', 00:05:19 INFO - 'USER': 'cltbld', 00:05:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:19 INFO - '_': '/tools/buildbot/bin/python'} 00:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:19 INFO - Downloading/unpacking jsonschema==2.5.1 00:05:19 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 00:05:19 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 00:05:19 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 00:05:19 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 00:05:19 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 00:05:19 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 00:05:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:05:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:05:21 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 00:05:21 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 00:05:21 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 00:05:21 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 00:05:21 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 00:05:21 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 00:05:21 INFO - Downloading functools32-3.2.3-2.tar.gz 00:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:05:21 INFO - warning: no files found matching '*.txt' 00:05:21 INFO - no previously-included directories found matching 'build' 00:05:21 INFO - no previously-included directories found matching 'dist' 00:05:21 INFO - no previously-included directories found matching '.git*' 00:05:21 INFO - Installing collected packages: jsonschema, functools32 00:05:21 INFO - Running setup.py install for functools32 00:05:21 INFO - warning: no files found matching '*.txt' 00:05:21 INFO - no previously-included directories found matching 'build' 00:05:21 INFO - no previously-included directories found matching 'dist' 00:05:21 INFO - no previously-included directories found matching '.git*' 00:05:22 INFO - Successfully installed jsonschema functools32 00:05:22 INFO - Cleaning up... 00:05:22 INFO - Return code: 0 00:05:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:05:22 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')]} 00:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:22 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')]} 00:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:22 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:22 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 00:05:22 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 00:05:22 INFO - Using env: {'DISPLAY': ':0', 00:05:22 INFO - 'HOME': '/home/cltbld', 00:05:22 INFO - 'LANG': 'en_US.UTF-8', 00:05:22 INFO - 'LANGUAGE': 'en_US:en', 00:05:22 INFO - 'LOGNAME': 'cltbld', 00:05:22 INFO - 'MAIL': '/var/mail/cltbld', 00:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:22 INFO - 'MOZ_NO_REMOTE': '1', 00:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:22 INFO - 'NO_EM_RESTART': '1', 00:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:22 INFO - 'PWD': '/builds/slave/test', 00:05:22 INFO - 'SHELL': '/bin/bash', 00:05:22 INFO - 'SHLVL': '1', 00:05:22 INFO - 'TERM': 'linux', 00:05:22 INFO - 'TMOUT': '86400', 00:05:22 INFO - 'USER': 'cltbld', 00:05:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:22 INFO - '_': '/tools/buildbot/bin/python'} 00:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:05:22 INFO - Cleaning up... 00:05:22 INFO - Return code: 0 00:05:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:22 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')]} 00:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:22 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')]} 00:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:22 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:22 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 00:05:22 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 00:05:22 INFO - Using env: {'DISPLAY': ':0', 00:05:22 INFO - 'HOME': '/home/cltbld', 00:05:22 INFO - 'LANG': 'en_US.UTF-8', 00:05:22 INFO - 'LANGUAGE': 'en_US:en', 00:05:22 INFO - 'LOGNAME': 'cltbld', 00:05:22 INFO - 'MAIL': '/var/mail/cltbld', 00:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:22 INFO - 'MOZ_NO_REMOTE': '1', 00:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:22 INFO - 'NO_EM_RESTART': '1', 00:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:22 INFO - 'PWD': '/builds/slave/test', 00:05:22 INFO - 'SHELL': '/bin/bash', 00:05:22 INFO - 'SHLVL': '1', 00:05:22 INFO - 'TERM': 'linux', 00:05:22 INFO - 'TMOUT': '86400', 00:05:22 INFO - 'USER': 'cltbld', 00:05:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:22 INFO - '_': '/tools/buildbot/bin/python'} 00:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:22 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:24 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:24 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 00:05:25 INFO - Downloading docopt-0.6.1.tar.gz 00:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:25 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:25 INFO - Running setup.py install for blobuploader 00:05:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:25 INFO - Running setup.py install for requests 00:05:25 INFO - Running setup.py install for docopt 00:05:25 INFO - Successfully installed blobuploader requests docopt 00:05:25 INFO - Cleaning up... 00:05:25 INFO - Return code: 0 00:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:25 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:25 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 00:05:25 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 00:05:25 INFO - Using env: {'DISPLAY': ':0', 00:05:25 INFO - 'HOME': '/home/cltbld', 00:05:25 INFO - 'LANG': 'en_US.UTF-8', 00:05:25 INFO - 'LANGUAGE': 'en_US:en', 00:05:25 INFO - 'LOGNAME': 'cltbld', 00:05:25 INFO - 'MAIL': '/var/mail/cltbld', 00:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:25 INFO - 'MOZ_NO_REMOTE': '1', 00:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:25 INFO - 'NO_EM_RESTART': '1', 00:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:25 INFO - 'PWD': '/builds/slave/test', 00:05:25 INFO - 'SHELL': '/bin/bash', 00:05:25 INFO - 'SHLVL': '1', 00:05:25 INFO - 'TERM': 'linux', 00:05:25 INFO - 'TMOUT': '86400', 00:05:25 INFO - 'USER': 'cltbld', 00:05:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:25 INFO - '_': '/tools/buildbot/bin/python'} 00:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:26 INFO - Running setup.py (path:/tmp/pip-hFo5Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:26 INFO - Running setup.py (path:/tmp/pip-4zN6k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:26 INFO - Running setup.py (path:/tmp/pip-sJUt0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:26 INFO - Running setup.py (path:/tmp/pip-KjJcjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:26 INFO - Running setup.py (path:/tmp/pip-Vv_ELj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:26 INFO - Running setup.py (path:/tmp/pip-nAt0YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:26 INFO - Running setup.py (path:/tmp/pip-kkbCm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:26 INFO - Running setup.py (path:/tmp/pip-JmhwXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:26 INFO - Running setup.py (path:/tmp/pip-CDK9Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:26 INFO - Running setup.py (path:/tmp/pip-URNtS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:26 INFO - Running setup.py (path:/tmp/pip-U3EJ30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:26 INFO - Running setup.py (path:/tmp/pip-OcxXGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:27 INFO - Running setup.py (path:/tmp/pip-fmr4Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:27 INFO - Running setup.py (path:/tmp/pip-RKXQqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:27 INFO - Running setup.py (path:/tmp/pip-JVYyR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:27 INFO - Running setup.py (path:/tmp/pip-AnzNd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:27 INFO - Running setup.py (path:/tmp/pip-_d7E__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:27 INFO - Running setup.py install for manifestparser 00:05:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:27 INFO - Running setup.py install for mozcrash 00:05:27 INFO - Running setup.py install for mozdebug 00:05:27 INFO - Running setup.py install for mozdevice 00:05:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:05:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:27 INFO - Running setup.py install for mozfile 00:05:27 INFO - Running setup.py install for mozhttpd 00:05:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:27 INFO - Running setup.py install for mozinfo 00:05:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for mozInstall 00:05:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for mozleak 00:05:28 INFO - Running setup.py install for mozlog 00:05:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for moznetwork 00:05:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for mozprocess 00:05:28 INFO - Running setup.py install for mozprofile 00:05:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for mozrunner 00:05:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:28 INFO - Running setup.py install for mozscreenshot 00:05:28 INFO - Running setup.py install for moztest 00:05:29 INFO - Running setup.py install for mozversion 00:05:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:29 INFO - Cleaning up... 00:05:29 INFO - Return code: 0 00:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:29 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:29 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 00:05:29 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 00:05:29 INFO - Using env: {'DISPLAY': ':0', 00:05:29 INFO - 'HOME': '/home/cltbld', 00:05:29 INFO - 'LANG': 'en_US.UTF-8', 00:05:29 INFO - 'LANGUAGE': 'en_US:en', 00:05:29 INFO - 'LOGNAME': 'cltbld', 00:05:29 INFO - 'MAIL': '/var/mail/cltbld', 00:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:29 INFO - 'MOZ_NO_REMOTE': '1', 00:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:29 INFO - 'NO_EM_RESTART': '1', 00:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:29 INFO - 'PWD': '/builds/slave/test', 00:05:29 INFO - 'SHELL': '/bin/bash', 00:05:29 INFO - 'SHLVL': '1', 00:05:29 INFO - 'TERM': 'linux', 00:05:29 INFO - 'TMOUT': '86400', 00:05:29 INFO - 'USER': 'cltbld', 00:05:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:29 INFO - '_': '/tools/buildbot/bin/python'} 00:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:29 INFO - Running setup.py (path:/tmp/pip-Mo88dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:29 INFO - Running setup.py (path:/tmp/pip-fYpIIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:29 INFO - Running setup.py (path:/tmp/pip-uyiFOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:29 INFO - Running setup.py (path:/tmp/pip-5rVl9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:29 INFO - Running setup.py (path:/tmp/pip-WuCQ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:29 INFO - Running setup.py (path:/tmp/pip-aWQdZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:29 INFO - Running setup.py (path:/tmp/pip-tejBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:29 INFO - Running setup.py (path:/tmp/pip-dOCJDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:29 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)) 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:29 INFO - Running setup.py (path:/tmp/pip-iI6Kg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:30 INFO - Running setup.py (path:/tmp/pip-4OLwjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:30 INFO - Running setup.py (path:/tmp/pip-0oxULg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:30 INFO - Running setup.py (path:/tmp/pip-877euk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:30 INFO - Running setup.py (path:/tmp/pip-N28si1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:30 INFO - Running setup.py (path:/tmp/pip-E48FIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:30 INFO - Running setup.py (path:/tmp/pip-LNSdSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:30 INFO - Running setup.py (path:/tmp/pip-7eH7qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:30 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)) 00:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:30 INFO - Running setup.py (path:/tmp/pip-nbNBSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:30 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)) 00:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:05:30 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)) 00:05:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:05:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:05:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05:32 INFO - Downloading blessings-1.6.tar.gz 00:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:32 INFO - Installing collected packages: blessings 00:05:32 INFO - Running setup.py install for blessings 00:05:32 INFO - Successfully installed blessings 00:05:32 INFO - Cleaning up... 00:05:32 INFO - Return code: 0 00:05:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:33 INFO - Reading from file tmpfile_stdout 00:05:33 INFO - Current package versions: 00:05:33 INFO - argparse == 1.2.1 00:05:33 INFO - blessings == 1.6 00:05:33 INFO - blobuploader == 1.2.4 00:05:33 INFO - docopt == 0.6.1 00:05:33 INFO - functools32 == 3.2.3-2 00:05:33 INFO - jsonschema == 2.5.1 00:05:33 INFO - manifestparser == 1.1 00:05:33 INFO - mozInstall == 1.12 00:05:33 INFO - mozcrash == 1.0 00:05:33 INFO - mozdebug == 0.1 00:05:33 INFO - mozdevice == 0.49 00:05:33 INFO - mozfile == 1.2 00:05:33 INFO - mozhttpd == 0.7 00:05:33 INFO - mozinfo == 0.9 00:05:33 INFO - mozleak == 0.1 00:05:33 INFO - mozlog == 3.4 00:05:33 INFO - moznetwork == 0.27 00:05:33 INFO - mozprocess == 0.23 00:05:33 INFO - mozprofile == 0.28 00:05:33 INFO - mozrunner == 6.13 00:05:33 INFO - mozscreenshot == 0.1 00:05:33 INFO - mozsystemmonitor == 0.3 00:05:33 INFO - moztest == 0.7 00:05:33 INFO - mozversion == 1.4 00:05:33 INFO - psutil == 3.1.1 00:05:33 INFO - requests == 1.2.3 00:05:33 INFO - wsgiref == 0.1.2 00:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:33 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 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05:33 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 00:05:33 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 00:05:33 INFO - Using env: {'DISPLAY': ':0', 00:05:33 INFO - 'HOME': '/home/cltbld', 00:05:33 INFO - 'LANG': 'en_US.UTF-8', 00:05:33 INFO - 'LANGUAGE': 'en_US:en', 00:05:33 INFO - 'LOGNAME': 'cltbld', 00:05:33 INFO - 'MAIL': '/var/mail/cltbld', 00:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:33 INFO - 'MOZ_NO_REMOTE': '1', 00:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:33 INFO - 'NO_EM_RESTART': '1', 00:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:33 INFO - 'PWD': '/builds/slave/test', 00:05:33 INFO - 'SHELL': '/bin/bash', 00:05:33 INFO - 'SHLVL': '1', 00:05:33 INFO - 'TERM': 'linux', 00:05:33 INFO - 'TMOUT': '86400', 00:05:33 INFO - 'USER': 'cltbld', 00:05:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:33 INFO - '_': '/tools/buildbot/bin/python'} 00:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 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)) 00:05:33 INFO - Cleaning up... 00:05:33 INFO - Return code: 0 00:05:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f066df2fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2777a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2915120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, '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': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', '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 00:05: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', 'jsonschema'] in /builds/slave/test/build 00:05: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 jsonschema 00:05:33 INFO - Using env: {'DISPLAY': ':0', 00:05:33 INFO - 'HOME': '/home/cltbld', 00:05:33 INFO - 'LANG': 'en_US.UTF-8', 00:05:33 INFO - 'LANGUAGE': 'en_US:en', 00:05:33 INFO - 'LOGNAME': 'cltbld', 00:05:33 INFO - 'MAIL': '/var/mail/cltbld', 00:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:33 INFO - 'MOZ_NO_REMOTE': '1', 00:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:33 INFO - 'NO_EM_RESTART': '1', 00:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:33 INFO - 'PWD': '/builds/slave/test', 00:05:33 INFO - 'SHELL': '/bin/bash', 00:05:33 INFO - 'SHLVL': '1', 00:05:33 INFO - 'TERM': 'linux', 00:05:33 INFO - 'TMOUT': '86400', 00:05:33 INFO - 'USER': 'cltbld', 00:05:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:33 INFO - '_': '/tools/buildbot/bin/python'} 00:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:05:33 INFO - Cleaning up... 00:05:33 INFO - Return code: 0 00:05:33 INFO - Running post-action listener: _resource_record_post_action 00:05:33 INFO - Running post-action listener: _start_resource_monitoring 00:05:33 INFO - Starting resource monitoring. 00:05:33 INFO - [mozharness: 2016-12-15 08:05:33.563000Z] Finished create-virtualenv step (success) 00:05:33 INFO - [mozharness: 2016-12-15 08:05:33.563476Z] Running install step. 00:05:33 INFO - Running pre-action listener: _resource_record_pre_action 00:05:33 INFO - Running main action method: install 00:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:33 INFO - Reading from file tmpfile_stdout 00:05:33 INFO - Detecting whether we're running mozinstall >=1.0... 00:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:05:33 INFO - Reading from file tmpfile_stdout 00:05:33 INFO - Output received: 00:05:33 INFO - Usage: mozinstall [options] installer 00:05:33 INFO - Options: 00:05:33 INFO - -h, --help show this help message and exit 00:05:33 INFO - -d DEST, --destination=DEST 00:05:33 INFO - Directory to install application into. [default: 00:05:33 INFO - "/builds/slave/test"] 00:05:33 INFO - --app=APP Application being installed. [default: firefox] 00:05:33 INFO - mkdir: /builds/slave/test/build/application 00:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:05:51 INFO - Reading from file tmpfile_stdout 00:05:51 INFO - Output received: 00:05:51 INFO - /builds/slave/test/build/application/firefox/firefox 00:05:51 INFO - Running post-action listener: _resource_record_post_action 00:05:51 INFO - [mozharness: 2016-12-15 08:05:51.359224Z] Finished install step (success) 00:05:51 INFO - [mozharness: 2016-12-15 08:05:51.359467Z] Running run-tests step. 00:05:51 INFO - Running pre-action listener: _resource_record_pre_action 00:05:51 INFO - Running main action method: run_tests 00:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:05:51 INFO - Python 2.7.3 00:05:51 INFO - Return code: 0 00:05:51 INFO - grabbing minidump binary from tooltool 00:05:51 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')]} 00:05:51 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 0x29a5f20>, '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 0x2912c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2912f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:05:51 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 00:05:51 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 00:05:51 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 00:05:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:05:51 INFO - Return code: 0 00:05:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:05:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:05:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:05:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:05:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 00:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 00:05:51 INFO - Using env: {'DISPLAY': ':0', 00:05:51 INFO - 'HOME': '/home/cltbld', 00:05:51 INFO - 'LANG': 'en_US.UTF-8', 00:05:51 INFO - 'LANGUAGE': 'en_US:en', 00:05:51 INFO - 'LOGNAME': 'cltbld', 00:05:51 INFO - 'MAIL': '/var/mail/cltbld', 00:05:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:51 INFO - 'MOZ_NO_REMOTE': '1', 00:05:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:51 INFO - 'NO_EM_RESTART': '1', 00:05:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:51 INFO - 'PWD': '/builds/slave/test', 00:05:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:51 INFO - 'SHELL': '/bin/bash', 00:05:51 INFO - 'SHLVL': '1', 00:05:51 INFO - 'TERM': 'linux', 00:05:51 INFO - 'TMOUT': '86400', 00:05:51 INFO - 'USER': 'cltbld', 00:05:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102', 00:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:51 INFO - '_': '/tools/buildbot/bin/python'} 00:05:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 00:05:51 INFO - mozversion application_buildid: 20161214223004 00:05:51 INFO - mozversion application_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 00:05:51 INFO - mozversion application_display_name: Nightly 00:05:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:05:51 INFO - mozversion application_name: Firefox 00:05:51 INFO - mozversion application_remotingname: firefox 00:05:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:05:51 INFO - mozversion application_vendor: Mozilla 00:05:51 INFO - mozversion application_version: 53.0a1 00:05:51 INFO - mozversion platform_buildid: 20161214223004 00:05:51 INFO - mozversion platform_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 00:05:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:05:51 INFO - mozversion platform_version: 53.0a1 00:05:51 INFO - using testdate: 1481789151 00:05:51 INFO - actual date: 1481789151 00:05:51 INFO - starting webserver on 'localhost:47949' 00:05:51 INFO - SUITE-START | Running 2 tests 00:05:51 INFO - TEST-START | dromaeo_css 00:05:51 INFO - operating with platform_type : linux_ 00:05:51 INFO - Initialising browser for dromaeo_css test... 00:05:51 INFO - TEST-INFO | started process 4132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_pgD6q/profile http://localhost:47949/getInfo.html) 00:05:55 INFO - PROCESS | 4132 | __metrics Screen width/height:1600/1200 00:05:55 INFO - PROCESS | 4132 | colorDepth:24 00:05:55 INFO - PROCESS | 4132 | Browser inner width/height: 1024/697 00:05:55 INFO - PROCESS | 4132 | __metrics 00:05:56 INFO - PROCESS | 4132 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:05:56 INFO - PROCESS | 4132 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:05:57 INFO - PROCESS | 4132 | console.error: PushService: 00:05:57 INFO - PROCESS | 4132 | stateChangeProcessEnqueue: Error transitioning state 00:05:57 INFO - PROCESS | 4132 | UnknownError 00:05:57 INFO - TEST-INFO | 4132: exit 0 00:05:57 INFO - Browser initialized. 00:05:57 INFO - Running cycle 1/1 for dromaeo_css test... 00:05:57 INFO - TEST-INFO | started process 4216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_pgD6q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:10 INFO - PROCESS | 4216 | RSS: Main: 172204032 00:06:10 INFO - PROCESS | 4216 | 00:07:01 INFO - PROCESS | 4216 | 1481789221254 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] 00:09:12 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47949/tests/dromaeo/cssquery-ext.html) 00:09:13 INFO - PROCESS | 4216 | RSS: Main: 286990336 00:09:13 INFO - PROCESS | 4216 | 00:12:16 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-ext.html (next: http://localhost:47949/tests/dromaeo/cssquery-jquery.html) 00:12:16 INFO - PROCESS | 4216 | RSS: Main: 284450816 00:12:16 INFO - PROCESS | 4216 | 00:15:18 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47949/tests/dromaeo/cssquery-mootools.html) 00:15:19 INFO - PROCESS | 4216 | RSS: Main: 250359808 00:15:19 INFO - PROCESS | 4216 | 00:18:21 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47949/tests/dromaeo/cssquery-prototype.html) 00:18:22 INFO - PROCESS | 4216 | RSS: Main: 239042560 00:18:22 INFO - PROCESS | 4216 | 00:21:25 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47949/tests/dromaeo/cssquery-yui.html) 00:21:25 INFO - PROCESS | 4216 | RSS: Main: 217997312 00:21:25 INFO - PROCESS | 4216 | 00:24:28 INFO - PROCESS | 4216 | Cycle 1(1): loaded http://localhost:47949/tests/dromaeo/cssquery-yui.html (next: http://localhost:47949/tests/dromaeo/cssquery-dojo.html) 00:24:29 INFO - PROCESS | 4216 | RSS: Main: 316100608 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | __start_tp_report 00:24:29 INFO - PROCESS | 4216 | _x_x_mozilla_page_load 00:24:29 INFO - PROCESS | 4216 | _x_x_mozilla_page_load_details 00:24:29 INFO - PROCESS | 4216 | |i|pagename|runs| 00:24:29 INFO - PROCESS | 4216 | |0;dojo.html;3018.396320735853;3072.646645635751;3076.138681169272;3105.456545104606;3120.6723294054123;5178.870528236786;5281.762320695569;5283.260343551906;5325.680459172448;5381.408045115034;5233.267342572043;5279.656822306557;5301.602379821509;5306.575473962083;5319.441458646845;4766.904661906759;4780.30685550595;4819.734914579697;4844.055409195208;4857.077155340492;4871.634627402959;4896.706197628136;4952.87617809554;4954.083494553501;4999.3000979862845;4661.696989695659;4880.023995200974;4882.951170488285;4928.605711543068;4962.60299176065;4702.788374523155;4762;4763.333133361332;4766.237402015696;4769.379980602499;4679.672422930396;4703.835365762182;4710.3405523226775;4717.292406139072;4717.599004084657;5107.591392688576;5151.871203219912;5157.48425157485;5208.479152084799;5227.529522343008;5648.74580643872;5648.74580643872;5649.8587535311535;5690.687012214326;5704.2299289595785;5724.8282551523525;5726.198332233491;5728.198052272685;5728.42715728428;5729.742161602738;5226.05930932432;5228.6339956203465;5276.34045744282;5344.091504444254;5349.331333583302;5718.914216286759;5758.2514273144225;5768.105943578668;5774.538036957033;5779.306483222041;5567.721613919369;5581.6371935824045;5585.525230355465;5586.497215250647;5590.664560126324;5590.748416321276;5593.328800543961;5606.467385598362;5643.266375371176;5689.118186681071;5617.578681598897;5627.324721033502;5627.493525582717;5629.493345598916;5634;5638.210650508932;5646.774129034792;5649.858753531194;5652.0391533439415;5697.116946873241;4257.978710106429;4305.7416555006175;4313.9137217255475;4323.913521729548;4342.82628694855;3898.7270891037356;3908.7459315144424;3911.159100793343;3946.9013274668364;3953.5651078381356;5360.3299587551555;5370.060239458079;5372.113601255749;5373.731313434313;5418.83743487696;5538.806141785019;5573.554115670737;5621.4659607337235;5652.576056795757;5671.971640141773;5296.04671159195;5314.867128321823;5331.253624492574;5361.865953351119;5383.892322153613;4891.608671306287;4892.8532144035735;4895.755212239374;4896.848108965094;4936.753162341868;5678.346990096192;5754.827355179351;5780.248567686174;5783.450572195635;5785.479306862402;5600.131979543177;5659.745311460912;5665.603407761417;5688.829335119953;5727.36998930109;5753.539716822728;5839.35767065614;5839.562032847469;5839.970800145972;5870.853228669317;5354.651947623392;5597.944020559742;5601.607887448003;5606.831795046155;5607.046802043744;5603.747831347518;5653;5659.971700141473;5691.658500489983;5771.336296325809;5607.971960140173;5610.382857885547;5612.831615051555;5613.971930140323;5621.690807005654;5576.33084029919;5577.525910297508;5586.748596313257;5586.804461843816;5587.720613969366;5381.542568881689;5450.672959622435;5461.781528738806;5462.235287059735;5487.478689524649;5563.8609034772835;5609.74756135983;5619.550435965195;5619.8876022480135;5636.464535869086;5302.284191634234;5409.972950135224;5486.369067557122;5495.395506494203;5496.835094947158 00:24:29 INFO - PROCESS | 4216 | |1;ext.html;552.6186931017597;563.4534501533511;570.9600327977042;573.6644063223017;583.480702175064;31472.84263578682;34111.488327675106;39955.00112497185;41280;41352.79323603385;43302.783486082524;43762.31089958309;43773;43797.12405751891;43828.12343753123;8480.74557763268;8660.956695216515;8671.43635663683;8675.783105422352;8677.219050285474;7879.4878332908465;8052.5973701315;10022.448765317904;10266.640667576636;10271.126954208901;10341.586336546528;10419.843702344471;10436.686899393031;10438.582456701723;10441.530131144078;10232.43721595312;10294.7426314342;10303.587856485768;10304.330218535772;10304.639337623148;10180.236482263786;10235.539400726911;10247.487625618764;10255.692329230134;10263.538140783683;40125.398119028236;40147.59852401497;40496.39255411171;40540.797296013625;40619.18761624781;3053.816770993725;3075.584796052549;3105.9378812423624;3341.5655964724674;3380.2732412531423;30497.695023049706;30666.23334416635;31060.689393106004;31160.220994475094;32430.513542296885;4022.3966405039478;4105.753654780723;4147.502299724022;4174.123434078847;4354.346847972798;310915;312952;313683;314808;315143;54094.45905540973;54738.5155300929;54801.9999999992;54841;54950;57196.42803571911;57486.42513574894;57628.8474230513;57716.711416442646;57913.71043144842;15693;15923.044617322766;15948.76076858848;15970.840291596935;15971.520854374387;9812.803743925082;10143.594256229668;11476.598319058792;11599.420028998516;11683.123765717604;15625.687486250212;15998.520044398687;16075.196240187945;16344.754828677342;16458.09480478561;5967.5524335675;6029.547783916224;6031.849203769853;6058.787942421994;6117;876.5923845411914;936.5691781780321;998.9200863931013;1003.3377970539555;1020.4642562654517;29586.704132958825;29887.701122988492;30788.538171927437;31096.68903310938;31162.68837311643;1015.2537884654773;1034.3225187502198;1074.5433190893839;1076.3219171921796;1163.5229555882047;13532.32338383077;14492.565547464133;14663.706725865422;14738.484153054806;14766.187859667822;474525;709502;733272;734228;739432;48468.75765621149;49420;49477.257841132414;49531.75234123878;49566.75216623966;1166.3934753928079;1221.8961388281919;1270.1743866486856;1285.8971282297393;1322.1141834970592;25787.742122578533;28596.85701571562;28729.712702872705;30166.396672065996;30412.517639080863;46893.53106468892;47397.52602473931;47447.288290676355;47459;47533.762331188125;401702;401987;402309;403537;403843;24441.75558244466;24766.628500572868;24787.25638230856;24938.501229975664;24961;35275.64724352826;35471.75848845278;40372;40557;43193.568064318955;33723.66276337303;34109.14727131841;34563.30873382569;35065;35361.64638353584;34372;35054.64945350616;35125;35265.47101793526;35667.46498802572;34741.305173895875;35971.640283596826;35977;36098;36304.455433168;29484;32535.18662033468;32709.18227044343;32813;32923.835380822944;24330.391740206636;24775;24877.253682389557;25068.49863002766;25081.74918250794 00:24:29 INFO - PROCESS | 4216 | |2;jquery.html;374.75266324226016;382.67472648248986;385.1238432565912;394.6980559871697;403.78397557306846;16671.249793759278;18847.340343087995;19228.711569326453;19401;19519.414417567477;18205.726914096267;18316.81683183171;18363.72454413185;18637;18656.25374984999;5456.154296084113;5477.75350109246;5721.6853073080965;5731.14032895067;5737.942620573783;5571.693556854371;5602.663840169603;5643.266375371196;5656.038473459501;5659.915101273484;5515.862103447405;5578.86052848678;5626;5627.296587926509;5631.267935168423;5442.292501974738;5588.133839254922;5589.664620122785;5589.972050139764;5590.608657393964;4958.652894297401;4961.801527938878;4992.700437973697;5001.374828146481;5012.1980483122525;21479.033443494925;21589.1364345426;21643.67534486984;21657.45856353588;21939.341819745434;2312.0520586559596;2495.6506089147533;2898.3188950596805;2954.23189970607;3006.6091408116804;13266.867331326755;14104.576862694135;14307.356168972421;14471;14512.129272243594;1796.4700413378084;1838.3657638114828;1925.075963537496;1943.620993906189;1952.2971730177126;72584.63707681428;72873.63563182204;73203.26796732072;73413;74783;9948.45283509414;9951.601935922627;10101.19190464761;10184.592616295266;10512.947435262928;14213.289335533182;14245.430182792572;14249.85750142506;14252.572422827332;14283.64290892736;7408.9629551851895;7831.686732530635;8026.799330016796;8038.718644847402;8139.918600814034;7511.32398084175;7557.811054723676;7758.32745880022;7781.649825757741;7820.257075577925;6339.66866957944;6372.100694184228;6375.394337537927;6381.840453988594;6481.8703625928165;1795.308806109657;1844.428227249557;1856.9535761606069;1870.43886833952;1912.2733361322607;708.4141543926179;816.2286639125969;875.9518226497477;897.8473659477904;945.1304701631951;18343.35798247055;18372;18497.81502184961;18924.526886827938;19296.22815087381;914.9359544831931;947.251671179774;953.7949340891741;966.3766870368573;973.4159504297365;10387.272890897564;10663.680089597325;10946.233763636468;10956.506957186946;11034.503447344889;387298;390527;392282;393288;397561;86542.56728716315;91119.54440227889;92016;92048;93405.53297233471;968.9612415503301;993.8658281131954;1027.7584767579613;1028.3932479836933;1037.4190453346;15457.5362739118;16810.159492025596;17153.31386744566;17270.568235794206;17566.648667026842;39784.40323395209;40092;40360;40640.18719625532;40974.385384218665;50796;54151.72924135354;54287.72856135694;54480.455195449125;54824.725876370365;8003;8170.550619715973;8214.753557393287;8329.416940814328;8434.114417986024;10379.167748766564;12458.875411245772;12529.169269206746;12654.304013279358;12931.094823362275;10772.838407423738;11006.559737610405;11078.113750899747;11161.944190278997;11330.546778128783;9999.450030248407;10461.26771126014;10613.150947923994;10886.23796334249;10992.780144396907;11168.441577920908;11194.384308863091;11212.55149793999;11382.430878455878;11682;8131.105578386491;8135.186481352054;8152.673893044212;8281.875771863306;8568.957155214184;8474.983002039548;10537.262391632512;10904.61833835812;10936.398498082683;11320.037796787365 00:24:29 INFO - PROCESS | 4216 | |3;mootools.html;1368.9247091409973;1383.619504636225;1447.9855201447983;1651.669666066787;1671.6907372136147;7463.7760867174;7710;7713.6143192840345;7716.845663086742;7719.575423351714;6670.299618540056;6859.03973443717;7364.852702945951;7550.660220290087;7573.015507983954;2147.162606583434;2196.8681879087226;2197.143114185469;2198.2635817001324;2199.3841724317135;2155.924542641008;2184.3446965910243;2188.9781102188936;2195.2536137713173;2196.2971849008322;2150.7956744109365;2154.655255159175;2167.0789914286365;2174.9565008699815;2179.0847843905517;2087.7912208779076;2099.3282149711945;2103.0536258683655;2110.6517424624917;2115.8201552868027;2140.8501404901663;2160.233117243372;2161.945951351213;2166.490874644457;2167.7615462299136;7553.811154721121;7618.733344332922;7655.043119610049;7690.5770182639935;7703;4736.360591320162;4877.414710234794;4892.168331383637;4897.559219670246;4903.754812259408;3057.8623961921767;3189.7607679424136;3247.3018301065385;3257.088015355704;3265.2163480764684;960.9135177833958;1013.8783345998528;1033.0237925160652;1067.3009178987775;1090.841827934945;10049.447280399576;10063.949680251626;10075.546600402999;10079.798404031879;10190.643327483576;4263.147370525907;4315.244832154361;4444.955550444519;4457.153140903218;4489.708168969007;8767.342449316327;8834.204921557091;8835.249003834746;8835.911640883638;8841.955790221007;4856.490068542823;4898.461169271377;4932.260160975882;4939.3084968104495;4940.1601727706375;3842.634949679776;4009.3384591542067;4536.56902594253;4542.636589072867;4562.68061235717;3553.289342131584;3656.323580137683;3670.7063434925144;3688.483612294281;3750.1374683822874;1194.5042807235075;1198.7422704118483;1200.2858299311895;1201.2912381694666;1213.9210951288137;795.1253621016835;834.8872902158131;898.9820203595891;924.177482040984;929.0987741890356;5172.741362931838;5238.319018527567;5503.422140675251;5540.141278101901;5598.97200514003;834.170000849159;878.8286284174652;917.0874979395411;923.6443969071821;956.2445667922402;3581.3732596795458;3686.5207523021836;3790.3556395412847;3794.5256842894637;3815.5802861685747;9047.502387368759;9266.814663706687;9353.064693530592;9369.672061477815;9391.812163756687;9374.78127843376;9377.765555861022;9380;9381.906180938104;9388.248940084777;6926.688299026455;7225.819354516074;7378.520396174232;7385.9630701846145;7395;5276.39321478035;5317.627766056339;5425.267588875451;5530.723463826712;5628.212050313042;8357.498550087013;8357.874631880648;8526.74419767408;8528.06191318942;8590.527520986156;8593.226609604915;8658.826823463369;8667.826643467222;8687.39188256816;8750.868736969078;6083.209182806207;6244.157038799885;6586.571872828443;6802.285759995129;6960.8955865663065;7117.039199707973;7360;7361.043064401593;7365.116186057493;7367.336939675455;6295.401936815995;6405.93594064072;6508.511861610304;6530.412262896362;6624.33756624353;6380.649064301508;6523.18460192476;6550.47596192313;6583.045458408408;6663.433608143362;6055.1220073090035;6082.695865206633;6157.96921015392;6158.3841615838055;6158.538109641884;4686.5782079613;4690.319903614025;4707.552782485658;4804.111239420718;4826.758662066813;4613.93079103807;4624.653151013755;4699.859004229878;4725.480197178239;4854.466008739107 00:24:29 INFO - PROCESS | 4216 | |4;prototype.html;350.45679197244283;360.31000633786283;370.54608105071276;371.68963915130865;374.59543692811764;5191.247269145972;5236.345456817898;5302.814401495948;5353.330833645799;5360.142377219646;4997.825076122336;5103.106956282654;5116.797552575151;5121.871953201163;5235.947640523603;4132.152908653718;4181.268278051344;4199.706020578561;4207.590457196843;4213.957860421403;4173.686973476986;4175.1858387614275;4188.937165942513;4193.308104162809;4231.624721965373;3925.8822235332987;4012.8394864205397;4111.465509483763;4171.270027745148;4196.244675958326;4174.829088873784;4176.519700234481;4179.582041795827;4181.310083836148;4186.790660466964;3761.1349389640263;3783.2433513297174;3783.6783873370523;3791.7724936503623;3793.3551296279697;4915.901681966377;5027.824026159067;5129.9230511542355;5150.819721309736;5178;4837.201861692816;4837.854864354075;4841.975790121062;4853.344798452199;4854.611631069506;5562.276904002454;5566.415526369754;5570.582206334541;5604.523615492688;5614.9612321720615;4068.9186216275803;4114.5679703630985;4115.73247738899;4185.665146788249;4191.622753952159;5578.804741834017;5651.756613545013;5660.773569057233;5665.830025099253;5684.532435214516;4273.487181538236;4275.87172384829;4276.134989557005;4276.807543660543;4297.484301883794;4115.1975364803575;4245.87262382129;4265.168292182994;4295.935560966588;4327.571901272572;4716.457607375196;4735.95264047362;4736.194846876039;4739.810407583658;4746.810127594927;5467.125259958388;5489.835304940858;5512.724363781795;5537.972310138504;5574.331080270394;1386.8682475164844;1405.206058576901;1413.2156653057446;1441.4162264282982;1465.6775509387917;979.2998006425298;1003.7540802503433;1019.6482213636284;1031.6079889641887;1035.5805898611075;5217.869553261123;5227.921581176285;5241.161414173714;5241.955637301456;5244.895102098013;5521.135205356267;5522.696251706115;5523.696196709139;5535.972320138373;5536.972315138399;5151.484851514893;5418.810341638103;5433.8369848904595;5446.673199608036;5452.236686863842;2956.4678357895787;2965.747911427553;2984.9552256716165;2992.431438026768;3003.5794988701164;5617.747201375948;5714.79998200061;5764.337101233328;5774.220480235199;5795.159701843293;5473.31583552056;5589.630540517518;5611.6352437091455;5658.490735833795;5669;5654.632448890891;5669.744861481243;5687.289088863892;5692.1461780733225;5702;5374.381946076252;5401.648892821954;5490.890182196414;5508.779648814003;5518.613697041169;5433.891322173614;5441.83674489766;5443.040505418126;5487.259220005249;5494.450554944474;5415.698105742062;5678.545716342765;5681.857953551194;5696.686682232517;5718.771249149988;3881.243157584244;3902.434147048605;3902.765834049966;3909.804509774443;3946.6053394660303;5472.589555783412;5529.838733865933;5551.611387202857;5564.4991950724625;5587.189857470726;5254.028004818968;5425.457454254543;5448.085274378189;5464.699441530754;5562.805301814417;5519.227308176778;5549.472800084147;5552.028395030773;5563.693996830213;5565.749541270734;5239.318888544617;5337.412884582615;5379.67721936685;5516.806911758069;5550.4449555045785;5621.690807005491;5635;5637.802676906289;5641.12562552805;5645.830625081254;5451.754671039892;5495.587830912617;5503.449655034465;5503.917441238465;5529.917051244154 00:24:29 INFO - PROCESS | 4216 | |5;yui.html;668.7993601919424;759.8746206875866;790.746960972489;792.6829268292682;811.2414892075911;15017;15202.163880986542;16231.107289099094;16261.593460163502;16269.430569930055;13914.373853176607;14036.157830530175;14057.15657060577;14080.225587592704;14099.08355956862;669.9330066993286;787.9953059848682;788.0582703669118;789.5223389849144;789.8617741895159;683.1904193530683;781.316348195329;787.1302211056785;797.8045378882182;805.6495424490336;799.7760627024443;801.7514570483169;801.791534201109;802.2819576479047;803.7186984555417;713.2831504338159;798.9560574168419;799.1808396393685;799.7640695994695;804.1516200408566;535.1330844032653;603.4086595136747;605.0953824033098;620.4756980351596;621.0839012456636;15127.621809454742;15160.772588411182;15162.772558411632;15166.165860877647;15173.924130379388;13361.131526450847;13518.662033449144;13662.590122296348;13757.449702011907;13842.446302147902;11571.826422603668;11596.246243994114;11596.59411920587;11720.062395008465;12276.693082672915;4120.423140760296;4155.210510003089;4207.410962465257;4277.529471758104;4294.484661840599;68158.9999999995;70135.29864701339;70143;70261.08172427933;70316.29683703149;10668.413237271869;10812.729681758019;10828.566857325777;10943.343399395902;10949.397783122005;20568.382948511568;20816.58366832685;21079.789202108088;21195.68206476904;21213.257535986166;7381.261873812683;7566.2433756625;7664.6934122635585;7667.8849817252785;7938.24586664266;4171.33258678616;4228.513720922072;4233.7671428071135;4280.72175308604;4323.0705398339505;3179.300553878143;3241.0600925731746;3272.051105179519;3272.2310257089566;3275.7870738402403;554.9750261238254;558.3857756467934;566.2497191221648;572.9312482502044;579.9072148456311;613.5242515251474;626.786892456567;651.8956966885276;660.5112216959416;660.9206895172514;8855.557222138867;8918.464892106495;9354.391964522285;9408.719032840041;9732.934125750508;561.1806762127259;570.1533223163599;590.5659340384814;625.2902955145942;637.9202599675041;4464.419625448736;4501.265545825709;4545.227311357077;4578.6794924355645;4585.72485650862;76085.61957190179;77747;77984.22015779883;79493.60253198813;79558;68758.31241687619;69471.65264173647;69641.65179174072;70097.29902700908;72805.63597182086;61371.69314153401;62084;62331.688341558;62568.37431625625;63262;8161.551114688749;8392;8564.614592343234;8603.82792344162;8680.088590697886;36534;40388;41383.793081034404;41718.374224386054;42717.3690236321;49941.50058499514;55070.44929550653;56145;57203;59277.40722592892;10491.318064325795;10682.519286631965;10870.728231793952;10953.671389858317;11005.17461190398;10454.790904181722;10595.205359597907;10851.45742712877;11033.44832758375;11231.887681123411;11530.250533715282;11629.418529073682;11871.881281187423;12478.251304921734;12543.87456125427;12436.813447798471;13519.188848668718;13630.386632601754;14020.929895350459;14212.431502739775;13612.251326177155;13911.095778774346;13928.442862285801;14665.633359166106;14789.926050369679;11324.37715925632;11370.578677665291;11441.771164576829;11518.366489842803;12219.755604887674;11803.881961180277;11879.168458208189;12058.638240852788;12086.112434492392;12124 00:24:29 INFO - PROCESS | 4216 | __end_tp_report 00:24:29 INFO - PROCESS | 4216 | __start_cc_report 00:24:29 INFO - PROCESS | 4216 | _x_x_mozilla_cycle_collect,1065 00:24:29 INFO - PROCESS | 4216 | __end_cc_report 00:24:29 INFO - PROCESS | 4216 | __startTimestamp1481790269026__endTimestamp 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | ------- Summary: start ------- 00:24:29 INFO - PROCESS | 4216 | Number of tests: 6 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#0] dojo.html Cycles:165 Average:5256.65 Median:5486.37 stddev:589.44 (10.7%) stddev-sans-first:564.49 00:24:29 INFO - PROCESS | 4216 | Values: 3018.4 3072.6 3076.1 3105.5 3120.7 5178.9 5281.8 5283.3 5325.7 5381.4 5233.3 5279.7 5301.6 5306.6 5319.4 4766.9 4780.3 4819.7 4844.1 4857.1 4871.6 4896.7 4952.9 4954.1 4999.3 4661.7 4880.0 4883.0 4928.6 4962.6 4702.8 4762.0 4763.3 4766.2 4769.4 4679.7 4703.8 4710.3 4717.3 4717.6 5107.6 5151.9 5157.5 5208.5 5227.5 5648.7 5648.7 5649.9 5690.7 5704.2 5724.8 5726.2 5728.2 5728.4 5729.7 5226.1 5228.6 5276.3 5344.1 5349.3 5718.9 5758.3 5768.1 5774.5 5779.3 5567.7 5581.6 5585.5 5586.5 5590.7 5590.7 5593.3 5606.5 5643.3 5689.1 5617.6 5627.3 5627.5 5629.5 5634.0 5638.2 5646.8 5649.9 5652.0 5697.1 4258.0 4305.7 4313.9 4323.9 4342.8 3898.7 3908.7 3911.2 3946.9 3953.6 5360.3 5370.1 5372.1 5373.7 5418.8 5538.8 5573.6 5621.5 5652.6 5672.0 5296.0 5314.9 5331.3 5361.9 5383.9 4891.6 4892.9 4895.8 4896.8 4936.8 5678.3 5754.8 5780.2 5783.5 5785.5 5600.1 5659.7 5665.6 5688.8 5727.4 5753.5 5839.4 5839.6 5840.0 5870.9 5354.7 5597.9 5601.6 5606.8 5607.0 5603.7 5653.0 5660.0 5691.7 5771.3 5608.0 5610.4 5612.8 5614.0 5621.7 5576.3 5577.5 5586.7 5586.8 5587.7 5381.5 5450.7 5461.8 5462.2 5487.5 5563.9 5609.7 5619.6 5619.9 5636.5 5302.3 5410.0 5486.4 5495.4 5496.8 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#1] ext.html Cycles:180 Average:60140.63 Median:18744.71 stddev:132469.08 (706.7%) stddev-sans-first:132765.14 00:24:29 INFO - PROCESS | 4216 | Values: 552.6 563.5 571.0 573.7 583.5 31472.8 34111.5 39955.0 41280.0 41352.8 43302.8 43762.3 43773.0 43797.1 43828.1 8480.7 8661.0 8671.4 8675.8 8677.2 7879.5 8052.6 10022.4 10266.6 10271.1 10341.6 10419.8 10436.7 10438.6 10441.5 10232.4 10294.7 10303.6 10304.3 10304.6 10180.2 10235.5 10247.5 10255.7 10263.5 40125.4 40147.6 40496.4 40540.8 40619.2 3053.8 3075.6 3105.9 3341.6 3380.3 30497.7 30666.2 31060.7 31160.2 32430.5 4022.4 4105.8 4147.5 4174.1 4354.3 310915.0 312952.0 313683.0 314808.0 315143.0 54094.5 54738.5 54802.0 54841.0 54950.0 57196.4 57486.4 57628.8 57716.7 57913.7 15693.0 15923.0 15948.8 15970.8 15971.5 9812.8 10143.6 11476.6 11599.4 11683.1 15625.7 15998.5 16075.2 16344.8 16458.1 5967.6 6029.5 6031.8 6058.8 6117.0 876.6 936.6 998.9 1003.3 1020.5 29586.7 29887.7 30788.5 31096.7 31162.7 1015.3 1034.3 1074.5 1076.3 1163.5 13532.3 14492.6 14663.7 14738.5 14766.2 474525.0 709502.0 733272.0 734228.0 739432.0 48468.8 49420.0 49477.3 49531.8 49566.8 1166.4 1221.9 1270.2 1285.9 1322.1 25787.7 28596.9 28729.7 30166.4 30412.5 46893.5 47397.5 47447.3 47459.0 47533.8 401702.0 401987.0 402309.0 403537.0 403843.0 24441.8 24766.6 24787.3 24938.5 24961.0 35275.6 35471.8 40372.0 40557.0 43193.6 33723.7 34109.1 34563.3 35065.0 35361.6 34372.0 35054.6 35125.0 35265.5 35667.5 34741.3 35971.6 35977.0 36098.0 36304.5 29484.0 32535.2 32709.2 32813.0 32923.8 24330.4 24775.0 24877.3 25068.5 25081.7 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#2] jquery.html Cycles:180 Average:25708.11 Median:196841.35 stddev:65102.13 (33.1%) stddev-sans-first:65256.97 00:24:29 INFO - PROCESS | 4216 | Values: 374.8 382.7 385.1 394.7 403.8 16671.2 18847.3 19228.7 19401.0 19519.4 18205.7 18316.8 18363.7 18637.0 18656.3 5456.2 5477.8 5721.7 5731.1 5737.9 5571.7 5602.7 5643.3 5656.0 5659.9 5515.9 5578.9 5626.0 5627.3 5631.3 5442.3 5588.1 5589.7 5590.0 5590.6 4958.7 4961.8 4992.7 5001.4 5012.2 21479.0 21589.1 21643.7 21657.5 21939.3 2312.1 2495.7 2898.3 2954.2 3006.6 13266.9 14104.6 14307.4 14471.0 14512.1 1796.5 1838.4 1925.1 1943.6 1952.3 72584.6 72873.6 73203.3 73413.0 74783.0 9948.5 9951.6 10101.2 10184.6 10512.9 14213.3 14245.4 14249.9 14252.6 14283.6 7409.0 7831.7 8026.8 8038.7 8139.9 7511.3 7557.8 7758.3 7781.6 7820.3 6339.7 6372.1 6375.4 6381.8 6481.9 1795.3 1844.4 1857.0 1870.4 1912.3 708.4 816.2 876.0 897.8 945.1 18343.4 18372.0 18497.8 18924.5 19296.2 914.9 947.3 953.8 966.4 973.4 10387.3 10663.7 10946.2 10956.5 11034.5 387298.0 390527.0 392282.0 393288.0 397561.0 86542.6 91119.5 92016.0 92048.0 93405.5 969.0 993.9 1027.8 1028.4 1037.4 15457.5 16810.2 17153.3 17270.6 17566.6 39784.4 40092.0 40360.0 40640.2 40974.4 50796.0 54151.7 54287.7 54480.5 54824.7 8003.0 8170.6 8214.8 8329.4 8434.1 10379.2 12458.9 12529.2 12654.3 12931.1 10772.8 11006.6 11078.1 11161.9 11330.5 9999.5 10461.3 10613.2 10886.2 10992.8 11168.4 11194.4 11212.6 11382.4 11682.0 8131.1 8135.2 8152.7 8281.9 8569.0 8475.0 10537.3 10904.6 10936.4 11320.0 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#3] mootools.html Cycles:180 Average:5087.91 Median:5257.36 stddev:2725.97 (51.9%) stddev-sans-first:2719.28 00:24:29 INFO - PROCESS | 4216 | Values: 1368.9 1383.6 1448.0 1651.7 1671.7 7463.8 7710.0 7713.6 7716.8 7719.6 6670.3 6859.0 7364.9 7550.7 7573.0 2147.2 2196.9 2197.1 2198.3 2199.4 2155.9 2184.3 2189.0 2195.3 2196.3 2150.8 2154.7 2167.1 2175.0 2179.1 2087.8 2099.3 2103.1 2110.7 2115.8 2140.9 2160.2 2161.9 2166.5 2167.8 7553.8 7618.7 7655.0 7690.6 7703.0 4736.4 4877.4 4892.2 4897.6 4903.8 3057.9 3189.8 3247.3 3257.1 3265.2 960.9 1013.9 1033.0 1067.3 1090.8 10049.4 10063.9 10075.5 10079.8 10190.6 4263.1 4315.2 4445.0 4457.2 4489.7 8767.3 8834.2 8835.2 8835.9 8842.0 4856.5 4898.5 4932.3 4939.3 4940.2 3842.6 4009.3 4536.6 4542.6 4562.7 3553.3 3656.3 3670.7 3688.5 3750.1 1194.5 1198.7 1200.3 1201.3 1213.9 795.1 834.9 899.0 924.2 929.1 5172.7 5238.3 5503.4 5540.1 5599.0 834.2 878.8 917.1 923.6 956.2 3581.4 3686.5 3790.4 3794.5 3815.6 9047.5 9266.8 9353.1 9369.7 9391.8 9374.8 9377.8 9380.0 9381.9 9388.2 6926.7 7225.8 7378.5 7386.0 7395.0 5276.4 5317.6 5425.3 5530.7 5628.2 8357.5 8357.9 8526.7 8528.1 8590.5 8593.2 8658.8 8667.8 8687.4 8750.9 6083.2 6244.2 6586.6 6802.3 6960.9 7117.0 7360.0 7361.0 7365.1 7367.3 6295.4 6405.9 6508.5 6530.4 6624.3 6380.6 6523.2 6550.5 6583.0 6663.4 6055.1 6082.7 6158.0 6158.4 6158.5 4686.6 4690.3 4707.6 4804.1 4826.8 4613.9 4624.7 4699.9 4725.5 4854.5 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#4] prototype.html Cycles:180 Average:4649.18 Median:5241.56 stddev:1323.85 (25.3%) stddev-sans-first:1287.64 00:24:29 INFO - PROCESS | 4216 | Values: 350.5 360.3 370.5 371.7 374.6 5191.2 5236.3 5302.8 5353.3 5360.1 4997.8 5103.1 5116.8 5121.9 5235.9 4132.2 4181.3 4199.7 4207.6 4214.0 4173.7 4175.2 4188.9 4193.3 4231.6 3925.9 4012.8 4111.5 4171.3 4196.2 4174.8 4176.5 4179.6 4181.3 4186.8 3761.1 3783.2 3783.7 3791.8 3793.4 4915.9 5027.8 5129.9 5150.8 5178.0 4837.2 4837.9 4842.0 4853.3 4854.6 5562.3 5566.4 5570.6 5604.5 5615.0 4068.9 4114.6 4115.7 4185.7 4191.6 5578.8 5651.8 5660.8 5665.8 5684.5 4273.5 4275.9 4276.1 4276.8 4297.5 4115.2 4245.9 4265.2 4295.9 4327.6 4716.5 4736.0 4736.2 4739.8 4746.8 5467.1 5489.8 5512.7 5538.0 5574.3 1386.9 1405.2 1413.2 1441.4 1465.7 979.3 1003.8 1019.6 1031.6 1035.6 5217.9 5227.9 5241.2 5242.0 5244.9 5521.1 5522.7 5523.7 5536.0 5537.0 5151.5 5418.8 5433.8 5446.7 5452.2 2956.5 2965.7 2985.0 2992.4 3003.6 5617.7 5714.8 5764.3 5774.2 5795.2 5473.3 5589.6 5611.6 5658.5 5669.0 5654.6 5669.7 5687.3 5692.1 5702.0 5374.4 5401.6 5490.9 5508.8 5518.6 5433.9 5441.8 5443.0 5487.3 5494.5 5415.7 5678.5 5681.9 5696.7 5718.8 3881.2 3902.4 3902.8 3909.8 3946.6 5472.6 5529.8 5551.6 5564.5 5587.2 5254.0 5425.5 5448.1 5464.7 5562.8 5519.2 5549.5 5552.0 5563.7 5565.7 5239.3 5337.4 5379.7 5516.8 5550.4 5621.7 5635.0 5637.8 5641.1 5645.8 5451.8 5495.6 5503.4 5503.9 5529.9 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - PROCESS | 4216 | [#5] yui.html Cycles:180 Average:16988.42 Median:4482.84 stddev:21813.02 (486.6%) stddev-sans-first:21839.79 00:24:29 INFO - PROCESS | 4216 | Values: 668.8 759.9 790.7 792.7 811.2 15017.0 15202.2 16231.1 16261.6 16269.4 13914.4 14036.2 14057.2 14080.2 14099.1 669.9 788.0 788.1 789.5 789.9 683.2 781.3 787.1 797.8 805.6 799.8 801.8 801.8 802.3 803.7 713.3 799.0 799.2 799.8 804.2 535.1 603.4 605.1 620.5 621.1 15127.6 15160.8 15162.8 15166.2 15173.9 13361.1 13518.7 13662.6 13757.4 13842.4 11571.8 11596.2 11596.6 11720.1 12276.7 4120.4 4155.2 4207.4 4277.5 4294.5 68159.0 70135.3 70143.0 70261.1 70316.3 10668.4 10812.7 10828.6 10943.3 10949.4 20568.4 20816.6 21079.8 21195.7 21213.3 7381.3 7566.2 7664.7 7667.9 7938.2 4171.3 4228.5 4233.8 4280.7 4323.1 3179.3 3241.1 3272.1 3272.2 3275.8 555.0 558.4 566.2 572.9 579.9 613.5 626.8 651.9 660.5 660.9 8855.6 8918.5 9354.4 9408.7 9732.9 561.2 570.2 590.6 625.3 637.9 4464.4 4501.3 4545.2 4578.7 4585.7 76085.6 77747.0 77984.2 79493.6 79558.0 68758.3 69471.7 69641.7 70097.3 72805.6 61371.7 62084.0 62331.7 62568.4 63262.0 8161.6 8392.0 8564.6 8603.8 8680.1 36534.0 40388.0 41383.8 41718.4 42717.4 49941.5 55070.4 56145.0 57203.0 59277.4 10491.3 10682.5 10870.7 10953.7 11005.2 10454.8 10595.2 10851.5 11033.4 11231.9 11530.3 11629.4 11871.9 12478.3 12543.9 12436.8 13519.2 13630.4 14020.9 14212.4 13612.3 13911.1 13928.4 14665.6 14789.9 11324.4 11370.6 11441.8 11518.4 12219.8 11803.9 11879.2 12058.6 12086.1 12124.0 00:24:29 INFO - PROCESS | 4216 | -------- Summary: end -------- 00:24:29 INFO - PROCESS | 4216 | 00:24:29 INFO - TEST-INFO | 4216: exit 0 00:24:30 INFO - TEST-OK | dromaeo_css | took 1118360ms 00:24:30 INFO - TEST-START | kraken 00:24:30 INFO - operating with platform_type : linux_ 00:24:30 INFO - Initialising browser for kraken test... 00:24:30 INFO - TEST-INFO | started process 4522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBEeO4/profile http://localhost:47949/getInfo.html) 00:24:34 INFO - PROCESS | 4522 | __metrics Screen width/height:1600/1200 00:24:34 INFO - PROCESS | 4522 | colorDepth:24 00:24:34 INFO - PROCESS | 4522 | Browser inner width/height: 1024/697 00:24:34 INFO - PROCESS | 4522 | __metrics 00:24:34 INFO - PROCESS | 4522 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:24:34 INFO - PROCESS | 4522 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:24:35 INFO - PROCESS | 4522 | console.error: PushService: 00:24:35 INFO - PROCESS | 4522 | stateChangeProcessEnqueue: Error transitioning state 00:24:35 INFO - PROCESS | 4522 | UnknownError 00:24:36 INFO - TEST-INFO | 4522: exit 0 00:24:36 INFO - Browser initialized. 00:24:36 INFO - Running cycle 1/1 for kraken test... 00:24:36 INFO - TEST-INFO | started process 4607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBEeO4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:48 INFO - PROCESS | 4607 | RSS: Main: 172208128 00:24:48 INFO - PROCESS | 4607 | 00:24:50 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47949/tests/kraken/driver.html?testName=audio-beat-detection) 00:24:51 INFO - PROCESS | 4607 | RSS: Main: 234586112 00:24:51 INFO - PROCESS | 4607 | 00:24:54 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47949/tests/kraken/driver.html?testName=audio-dft) 00:24:54 INFO - PROCESS | 4607 | RSS: Main: 216616960 00:24:54 INFO - PROCESS | 4607 | 00:24:57 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47949/tests/kraken/driver.html?testName=audio-fft) 00:24:58 INFO - PROCESS | 4607 | RSS: Main: 298524672 00:24:58 INFO - PROCESS | 4607 | 00:25:00 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47949/tests/kraken/driver.html?testName=audio-oscillator) 00:25:01 INFO - PROCESS | 4607 | RSS: Main: 208990208 00:25:01 INFO - PROCESS | 4607 | 00:25:03 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:03 INFO - PROCESS | 4607 | RSS: Main: 213581824 00:25:03 INFO - PROCESS | 4607 | 00:25:07 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47949/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:07 INFO - PROCESS | 4607 | RSS: Main: 252772352 00:25:07 INFO - PROCESS | 4607 | 00:25:11 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47949/tests/kraken/driver.html?testName=imaging-desaturate) 00:25:11 INFO - PROCESS | 4607 | RSS: Main: 252469248 00:25:11 INFO - PROCESS | 4607 | 00:25:14 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47949/tests/kraken/driver.html?testName=json-parse-financial) 00:25:15 INFO - PROCESS | 4607 | RSS: Main: 251363328 00:25:15 INFO - PROCESS | 4607 | 00:25:16 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:25:17 INFO - PROCESS | 4607 | RSS: Main: 213594112 00:25:17 INFO - PROCESS | 4607 | 00:25:18 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:19 INFO - PROCESS | 4607 | RSS: Main: 219942912 00:25:19 INFO - PROCESS | 4607 | 00:25:21 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:22 INFO - PROCESS | 4607 | RSS: Main: 229511168 00:25:22 INFO - PROCESS | 4607 | 00:25:24 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:25 INFO - PROCESS | 4607 | RSS: Main: 239333376 00:25:25 INFO - PROCESS | 4607 | 00:25:28 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:29 INFO - PROCESS | 4607 | RSS: Main: 235347968 00:25:29 INFO - PROCESS | 4607 | 00:25:30 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:47949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47949/tests/kraken/driver.html?testName=ai-astar) 00:25:31 INFO - PROCESS | 4607 | RSS: Main: 285683712 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | __start_tp_report 00:25:31 INFO - PROCESS | 4607 | _x_x_mozilla_page_load 00:25:31 INFO - PROCESS | 4607 | _x_x_mozilla_page_load_details 00:25:31 INFO - PROCESS | 4607 | |i|pagename|runs| 00:25:31 INFO - PROCESS | 4607 | |0;ai-astar;104;112;113;114;113;113;112;112;112;112 00:25:31 INFO - PROCESS | 4607 | |1;audio-beat-detection;149;123;126;160;127;125;126;128;138;123 00:25:31 INFO - PROCESS | 4607 | |2;audio-dft;159;162;160;161;160;162;160;160;162;159 00:25:31 INFO - PROCESS | 4607 | |3;audio-fft;75;76;75;115;76;75;76;76;95;76 00:25:31 INFO - PROCESS | 4607 | |4;audio-oscillator;84;84;103;84;84;84;95;84;83;102 00:25:31 INFO - PROCESS | 4607 | |5;imaging-gaussian-blur;127;128;127;127;127;127;127;127;127;127 00:25:31 INFO - PROCESS | 4607 | |6;imaging-darkroom;148;148;147;147;146;147;147;147;147;147 00:25:31 INFO - PROCESS | 4607 | |7;imaging-desaturate;96;95;96;96;96;96;95;95;95;96 00:25:31 INFO - PROCESS | 4607 | |8;json-parse-financial;54;55;55;54;55;55;54;65;55;56 00:25:31 INFO - PROCESS | 4607 | |9;json-stringify-tinderbox;64;64;63;64;64;63;63;64;63;65 00:25:31 INFO - PROCESS | 4607 | |10;stanford-crypto-aes;81;83;81;90;82;81;83;81;81;88 00:25:31 INFO - PROCESS | 4607 | |11;stanford-crypto-ccm;144;142;147;150;130;130;132;130;184;143 00:25:31 INFO - PROCESS | 4607 | |12;stanford-crypto-pbkdf2;171;168;173;171;167;173;167;171;173;167 00:25:31 INFO - PROCESS | 4607 | |13;stanford-crypto-sha256-iterative;66;71;65;69;65;63;64;63;63;63 00:25:31 INFO - PROCESS | 4607 | __end_tp_report 00:25:31 INFO - PROCESS | 4607 | __start_cc_report 00:25:31 INFO - PROCESS | 4607 | _x_x_mozilla_cycle_collect,1641 00:25:31 INFO - PROCESS | 4607 | __end_cc_report 00:25:31 INFO - PROCESS | 4607 | __startTimestamp1481790331055__endTimestamp 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | ------- Summary: start ------- 00:25:31 INFO - PROCESS | 4607 | Number of tests: 14 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.79 (2.5%) stddev-sans-first:0.73 00:25:31 INFO - PROCESS | 4607 | Values: 104.0 112.0 113.0 114.0 113.0 113.0 112.0 112.0 112.0 112.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:127.50 stddev:12.61 (9.9%) stddev-sans-first:11.87 00:25:31 INFO - PROCESS | 4607 | Values: 149.0 123.0 126.0 160.0 127.0 125.0 126.0 128.0 138.0 123.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.18 (0.7%) stddev-sans-first:1.12 00:25:31 INFO - PROCESS | 4607 | Values: 159.0 162.0 160.0 161.0 160.0 162.0 160.0 160.0 162.0 159.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:13.26 (17.4%) stddev-sans-first:13.85 00:25:31 INFO - PROCESS | 4607 | Values: 75.0 76.0 75.0 115.0 76.0 75.0 76.0 76.0 95.0 76.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:84.00 stddev:8.07 (9.6%) stddev-sans-first:8.38 00:25:31 INFO - PROCESS | 4607 | Values: 84.0 84.0 103.0 84.0 84.0 84.0 95.0 84.0 83.0 102.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#5] imaging-gaussian-blur Cycles:10 Average:127.10 Median:127.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 00:25:31 INFO - PROCESS | 4607 | Values: 127.0 128.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 00:25:31 INFO - PROCESS | 4607 | Values: 148.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:25:31 INFO - PROCESS | 4607 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.29 (6.0%) stddev-sans-first:3.43 00:25:31 INFO - PROCESS | 4607 | Values: 54.0 55.0 55.0 54.0 55.0 55.0 54.0 65.0 55.0 56.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 00:25:31 INFO - PROCESS | 4607 | Values: 64.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 63.0 65.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:3.25 (3.9%) stddev-sans-first:3.35 00:25:31 INFO - PROCESS | 4607 | Values: 81.0 83.0 81.0 90.0 82.0 81.0 83.0 81.0 81.0 88.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:143.50 stddev:16.25 (11.3%) stddev-sans-first:17.23 00:25:31 INFO - PROCESS | 4607 | Values: 144.0 142.0 147.0 150.0 130.0 130.0 132.0 130.0 184.0 143.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:171.00 stddev:2.60 (1.5%) stddev-sans-first:2.74 00:25:31 INFO - PROCESS | 4607 | Values: 171.0 168.0 173.0 171.0 167.0 173.0 167.0 171.0 173.0 167.0 00:25:31 INFO - PROCESS | 4607 | 00:25:31 INFO - PROCESS | 4607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.78 (4.3%) stddev-sans-first:2.93 00:25:31 INFO - PROCESS | 4607 | Values: 66.0 71.0 65.0 69.0 65.0 63.0 64.0 63.0 63.0 63.0 00:25:31 INFO - PROCESS | 4607 | -------- Summary: end -------- 00:25:31 INFO - PROCESS | 4607 | 00:25:32 INFO - TEST-INFO | 4607: exit 0 00:25:32 INFO - TEST-OK | kraken | took 62322ms 00:25:32 INFO - SUITE-END | took 1180s 00:25:32 INFO - Completed test suite (00:19:41) 00:25:32 INFO - javascript benchmark 00:25:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.396320735853, 3072.646645635751, 3076.138681169272, 3105.456545104606, 3120.6723294054123, 5178.870528236786, 5281.762320695569, 5283.260343551906, 5325.680459172448, 5381.408045115034, 5233.267342572043, 5279.656822306557, 5301.602379821509, 5306.575473962083, 5319.441458646845, 4766.904661906759, 4780.30685550595, 4819.734914579697, 4844.055409195208, 4857.077155340492, 4871.634627402959, 4896.706197628136, 4952.87617809554, 4954.083494553501, 4999.3000979862845, 4661.696989695659, 4880.023995200974, 4882.951170488285, 4928.605711543068, 4962.60299176065, 4702.788374523155, 4762.0, 4763.333133361332, 4766.237402015696, 4769.379980602499, 4679.672422930396, 4703.835365762182, 4710.3405523226775, 4717.292406139072, 4717.599004084657, 5107.591392688576, 5151.871203219912, 5157.48425157485, 5208.479152084799, 5227.529522343008, 5648.74580643872, 5648.74580643872, 5649.8587535311535, 5690.687012214326, 5704.2299289595785, 5724.8282551523525, 5726.198332233491, 5728.198052272685, 5728.42715728428, 5729.742161602738, 5226.05930932432, 5228.6339956203465, 5276.34045744282, 5344.091504444254, 5349.331333583302, 5718.914216286759, 5758.2514273144225, 5768.105943578668, 5774.538036957033, 5779.306483222041, 5567.721613919369, 5581.6371935824045, 5585.525230355465, 5586.497215250647, 5590.664560126324, 5590.748416321276, 5593.328800543961, 5606.467385598362, 5643.266375371176, 5689.118186681071, 5617.578681598897, 5627.324721033502, 5627.493525582717, 5629.493345598916, 5634.0, 5638.210650508932, 5646.774129034792, 5649.858753531194, 5652.0391533439415, 5697.116946873241, 4257.978710106429, 4305.7416555006175, 4313.9137217255475, 4323.913521729548, 4342.82628694855, 3898.7270891037356, 3908.7459315144424, 3911.159100793343, 3946.9013274668364, 3953.5651078381356, 5360.3299587551555, 5370.060239458079, 5372.113601255749, 5373.731313434313, 5418.83743487696, 5538.806141785019, 5573.554115670737, 5621.4659607337235, 5652.576056795757, 5671.971640141773, 5296.04671159195, 5314.867128321823, 5331.253624492574, 5361.865953351119, 5383.892322153613, 4891.608671306287, 4892.8532144035735, 4895.755212239374, 4896.848108965094, 4936.753162341868, 5678.346990096192, 5754.827355179351, 5780.248567686174, 5783.450572195635, 5785.479306862402, 5600.131979543177, 5659.745311460912, 5665.603407761417, 5688.829335119953, 5727.36998930109, 5753.539716822728, 5839.35767065614, 5839.562032847469, 5839.970800145972, 5870.853228669317, 5354.651947623392, 5597.944020559742, 5601.607887448003, 5606.831795046155, 5607.046802043744, 5603.747831347518, 5653.0, 5659.971700141473, 5691.658500489983, 5771.336296325809, 5607.971960140173, 5610.382857885547, 5612.831615051555, 5613.971930140323, 5621.690807005654, 5576.33084029919, 5577.525910297508, 5586.748596313257, 5586.804461843816, 5587.720613969366, 5381.542568881689, 5450.672959622435, 5461.781528738806, 5462.235287059735, 5487.478689524649, 5563.8609034772835, 5609.74756135983, 5619.550435965195, 5619.8876022480135, 5636.464535869086, 5302.284191634234, 5409.972950135224, 5486.369067557122, 5495.395506494203, 5496.835094947158], "value": 5217.345875400557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.6186931017597, 563.4534501533511, 570.9600327977042, 573.6644063223017, 583.480702175064, 31472.84263578682, 34111.488327675106, 39955.00112497185, 41280.0, 41352.79323603385, 43302.783486082524, 43762.31089958309, 43773.0, 43797.12405751891, 43828.12343753123, 8480.74557763268, 8660.956695216515, 8671.43635663683, 8675.783105422352, 8677.219050285474, 7879.4878332908465, 8052.5973701315, 10022.448765317904, 10266.640667576636, 10271.126954208901, 10341.586336546528, 10419.843702344471, 10436.686899393031, 10438.582456701723, 10441.530131144078, 10232.43721595312, 10294.7426314342, 10303.587856485768, 10304.330218535772, 10304.639337623148, 10180.236482263786, 10235.539400726911, 10247.487625618764, 10255.692329230134, 10263.538140783683, 40125.398119028236, 40147.59852401497, 40496.39255411171, 40540.797296013625, 40619.18761624781, 3053.816770993725, 3075.584796052549, 3105.9378812423624, 3341.5655964724674, 3380.2732412531423, 30497.695023049706, 30666.23334416635, 31060.689393106004, 31160.220994475094, 32430.513542296885, 4022.3966405039478, 4105.753654780723, 4147.502299724022, 4174.123434078847, 4354.346847972798, 310915.0, 312952.0, 313683.0, 314808.0, 315143.0, 54094.45905540973, 54738.5155300929, 54801.9999999992, 54841.0, 54950.0, 57196.42803571911, 57486.42513574894, 57628.8474230513, 57716.711416442646, 57913.71043144842, 15693.0, 15923.044617322766, 15948.76076858848, 15970.840291596935, 15971.520854374387, 9812.803743925082, 10143.594256229668, 11476.598319058792, 11599.420028998516, 11683.123765717604, 15625.687486250212, 15998.520044398687, 16075.196240187945, 16344.754828677342, 16458.09480478561, 5967.5524335675, 6029.547783916224, 6031.849203769853, 6058.787942421994, 6117.0, 876.5923845411914, 936.5691781780321, 998.9200863931013, 1003.3377970539555, 1020.4642562654517, 29586.704132958825, 29887.701122988492, 30788.538171927437, 31096.68903310938, 31162.68837311643, 1015.2537884654773, 1034.3225187502198, 1074.5433190893839, 1076.3219171921796, 1163.5229555882047, 13532.32338383077, 14492.565547464133, 14663.706725865422, 14738.484153054806, 14766.187859667822, 474525.0, 709502.0, 733272.0, 734228.0, 739432.0, 48468.75765621149, 49420.0, 49477.257841132414, 49531.75234123878, 49566.75216623966, 1166.3934753928079, 1221.8961388281919, 1270.1743866486856, 1285.8971282297393, 1322.1141834970592, 25787.742122578533, 28596.85701571562, 28729.712702872705, 30166.396672065996, 30412.517639080863, 46893.53106468892, 47397.52602473931, 47447.288290676355, 47459.0, 47533.762331188125, 401702.0, 401987.0, 402309.0, 403537.0, 403843.0, 24441.75558244466, 24766.628500572868, 24787.25638230856, 24938.501229975664, 24961.0, 35275.64724352826, 35471.75848845278, 40372.0, 40557.0, 43193.568064318955, 33723.66276337303, 34109.14727131841, 34563.30873382569, 35065.0, 35361.64638353584, 34372.0, 35054.64945350616, 35125.0, 35265.47101793526, 35667.46498802572, 34741.305173895875, 35971.640283596826, 35977.0, 36098.0, 36304.455433168, 29484.0, 32535.18662033468, 32709.18227044343, 32813.0, 32923.835380822944, 24330.391740206636, 24775.0, 24877.253682389557, 25068.49863002766, 25081.74918250794], "value": 18847.016397403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.75266324226016, 382.67472648248986, 385.1238432565912, 394.6980559871697, 403.78397557306846, 16671.249793759278, 18847.340343087995, 19228.711569326453, 19401.0, 19519.414417567477, 18205.726914096267, 18316.81683183171, 18363.72454413185, 18637.0, 18656.25374984999, 5456.154296084113, 5477.75350109246, 5721.6853073080965, 5731.14032895067, 5737.942620573783, 5571.693556854371, 5602.663840169603, 5643.266375371196, 5656.038473459501, 5659.915101273484, 5515.862103447405, 5578.86052848678, 5626.0, 5627.296587926509, 5631.267935168423, 5442.292501974738, 5588.133839254922, 5589.664620122785, 5589.972050139764, 5590.608657393964, 4958.652894297401, 4961.801527938878, 4992.700437973697, 5001.374828146481, 5012.1980483122525, 21479.033443494925, 21589.1364345426, 21643.67534486984, 21657.45856353588, 21939.341819745434, 2312.0520586559596, 2495.6506089147533, 2898.3188950596805, 2954.23189970607, 3006.6091408116804, 13266.867331326755, 14104.576862694135, 14307.356168972421, 14471.0, 14512.129272243594, 1796.4700413378084, 1838.3657638114828, 1925.075963537496, 1943.620993906189, 1952.2971730177126, 72584.63707681428, 72873.63563182204, 73203.26796732072, 73413.0, 74783.0, 9948.45283509414, 9951.601935922627, 10101.19190464761, 10184.592616295266, 10512.947435262928, 14213.289335533182, 14245.430182792572, 14249.85750142506, 14252.572422827332, 14283.64290892736, 7408.9629551851895, 7831.686732530635, 8026.799330016796, 8038.718644847402, 8139.918600814034, 7511.32398084175, 7557.811054723676, 7758.32745880022, 7781.649825757741, 7820.257075577925, 6339.66866957944, 6372.100694184228, 6375.394337537927, 6381.840453988594, 6481.8703625928165, 1795.308806109657, 1844.428227249557, 1856.9535761606069, 1870.43886833952, 1912.2733361322607, 708.4141543926179, 816.2286639125969, 875.9518226497477, 897.8473659477904, 945.1304701631951, 18343.35798247055, 18372.0, 18497.81502184961, 18924.526886827938, 19296.22815087381, 914.9359544831931, 947.251671179774, 953.7949340891741, 966.3766870368573, 973.4159504297365, 10387.272890897564, 10663.680089597325, 10946.233763636468, 10956.506957186946, 11034.503447344889, 387298.0, 390527.0, 392282.0, 393288.0, 397561.0, 86542.56728716315, 91119.54440227889, 92016.0, 92048.0, 93405.53297233471, 968.9612415503301, 993.8658281131954, 1027.7584767579613, 1028.3932479836933, 1037.4190453346, 15457.5362739118, 16810.159492025596, 17153.31386744566, 17270.568235794206, 17566.648667026842, 39784.40323395209, 40092.0, 40360.0, 40640.18719625532, 40974.385384218665, 50796.0, 54151.72924135354, 54287.72856135694, 54480.455195449125, 54824.725876370365, 8003.0, 8170.550619715973, 8214.753557393287, 8329.416940814328, 8434.114417986024, 10379.167748766564, 12458.875411245772, 12529.169269206746, 12654.304013279358, 12931.094823362275, 10772.838407423738, 11006.559737610405, 11078.113750899747, 11161.944190278997, 11330.546778128783, 9999.450030248407, 10461.26771126014, 10613.150947923994, 10886.23796334249, 10992.780144396907, 11168.441577920908, 11194.384308863091, 11212.55149793999, 11382.430878455878, 11682.0, 8131.105578386491, 8135.186481352054, 8152.673893044212, 8281.875771863306, 8568.957155214184, 8474.983002039548, 10537.262391632512, 10904.61833835812, 10936.398498082683, 11320.037796787365], "value": 8966.456638924612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.9247091409973, 1383.619504636225, 1447.9855201447983, 1651.669666066787, 1671.6907372136147, 7463.7760867174, 7710.0, 7713.6143192840345, 7716.845663086742, 7719.575423351714, 6670.299618540056, 6859.03973443717, 7364.852702945951, 7550.660220290087, 7573.015507983954, 2147.162606583434, 2196.8681879087226, 2197.143114185469, 2198.2635817001324, 2199.3841724317135, 2155.924542641008, 2184.3446965910243, 2188.9781102188936, 2195.2536137713173, 2196.2971849008322, 2150.7956744109365, 2154.655255159175, 2167.0789914286365, 2174.9565008699815, 2179.0847843905517, 2087.7912208779076, 2099.3282149711945, 2103.0536258683655, 2110.6517424624917, 2115.8201552868027, 2140.8501404901663, 2160.233117243372, 2161.945951351213, 2166.490874644457, 2167.7615462299136, 7553.811154721121, 7618.733344332922, 7655.043119610049, 7690.5770182639935, 7703.0, 4736.360591320162, 4877.414710234794, 4892.168331383637, 4897.559219670246, 4903.754812259408, 3057.8623961921767, 3189.7607679424136, 3247.3018301065385, 3257.088015355704, 3265.2163480764684, 960.9135177833958, 1013.8783345998528, 1033.0237925160652, 1067.3009178987775, 1090.841827934945, 10049.447280399576, 10063.949680251626, 10075.546600402999, 10079.798404031879, 10190.643327483576, 4263.147370525907, 4315.244832154361, 4444.955550444519, 4457.153140903218, 4489.708168969007, 8767.342449316327, 8834.204921557091, 8835.249003834746, 8835.911640883638, 8841.955790221007, 4856.490068542823, 4898.461169271377, 4932.260160975882, 4939.3084968104495, 4940.1601727706375, 3842.634949679776, 4009.3384591542067, 4536.56902594253, 4542.636589072867, 4562.68061235717, 3553.289342131584, 3656.323580137683, 3670.7063434925144, 3688.483612294281, 3750.1374683822874, 1194.5042807235075, 1198.7422704118483, 1200.2858299311895, 1201.2912381694666, 1213.9210951288137, 795.1253621016835, 834.8872902158131, 898.9820203595891, 924.177482040984, 929.0987741890356, 5172.741362931838, 5238.319018527567, 5503.422140675251, 5540.141278101901, 5598.97200514003, 834.170000849159, 878.8286284174652, 917.0874979395411, 923.6443969071821, 956.2445667922402, 3581.3732596795458, 3686.5207523021836, 3790.3556395412847, 3794.5256842894637, 3815.5802861685747, 9047.502387368759, 9266.814663706687, 9353.064693530592, 9369.672061477815, 9391.812163756687, 9374.78127843376, 9377.765555861022, 9380.0, 9381.906180938104, 9388.248940084777, 6926.688299026455, 7225.819354516074, 7378.520396174232, 7385.9630701846145, 7395.0, 5276.39321478035, 5317.627766056339, 5425.267588875451, 5530.723463826712, 5628.212050313042, 8357.498550087013, 8357.874631880648, 8526.74419767408, 8528.06191318942, 8590.527520986156, 8593.226609604915, 8658.826823463369, 8667.826643467222, 8687.39188256816, 8750.868736969078, 6083.209182806207, 6244.157038799885, 6586.571872828443, 6802.285759995129, 6960.8955865663065, 7117.039199707973, 7360.0, 7361.043064401593, 7365.116186057493, 7367.336939675455, 6295.401936815995, 6405.93594064072, 6508.511861610304, 6530.412262896362, 6624.33756624353, 6380.649064301508, 6523.18460192476, 6550.47596192313, 6583.045458408408, 6663.433608143362, 6055.1220073090035, 6082.695865206633, 6157.96921015392, 6158.3841615838055, 6158.538109641884, 4686.5782079613, 4690.319903614025, 4707.552782485658, 4804.111239420718, 4826.758662066813, 4613.93079103807, 4624.653151013755, 4699.859004229878, 4725.480197178239, 4854.466008739107], "value": 4160.961473826191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.45679197244283, 360.31000633786283, 370.54608105071276, 371.68963915130865, 374.59543692811764, 5191.247269145972, 5236.345456817898, 5302.814401495948, 5353.330833645799, 5360.142377219646, 4997.825076122336, 5103.106956282654, 5116.797552575151, 5121.871953201163, 5235.947640523603, 4132.152908653718, 4181.268278051344, 4199.706020578561, 4207.590457196843, 4213.957860421403, 4173.686973476986, 4175.1858387614275, 4188.937165942513, 4193.308104162809, 4231.624721965373, 3925.8822235332987, 4012.8394864205397, 4111.465509483763, 4171.270027745148, 4196.244675958326, 4174.829088873784, 4176.519700234481, 4179.582041795827, 4181.310083836148, 4186.790660466964, 3761.1349389640263, 3783.2433513297174, 3783.6783873370523, 3791.7724936503623, 3793.3551296279697, 4915.901681966377, 5027.824026159067, 5129.9230511542355, 5150.819721309736, 5178.0, 4837.201861692816, 4837.854864354075, 4841.975790121062, 4853.344798452199, 4854.611631069506, 5562.276904002454, 5566.415526369754, 5570.582206334541, 5604.523615492688, 5614.9612321720615, 4068.9186216275803, 4114.5679703630985, 4115.73247738899, 4185.665146788249, 4191.622753952159, 5578.804741834017, 5651.756613545013, 5660.773569057233, 5665.830025099253, 5684.532435214516, 4273.487181538236, 4275.87172384829, 4276.134989557005, 4276.807543660543, 4297.484301883794, 4115.1975364803575, 4245.87262382129, 4265.168292182994, 4295.935560966588, 4327.571901272572, 4716.457607375196, 4735.95264047362, 4736.194846876039, 4739.810407583658, 4746.810127594927, 5467.125259958388, 5489.835304940858, 5512.724363781795, 5537.972310138504, 5574.331080270394, 1386.8682475164844, 1405.206058576901, 1413.2156653057446, 1441.4162264282982, 1465.6775509387917, 979.2998006425298, 1003.7540802503433, 1019.6482213636284, 1031.6079889641887, 1035.5805898611075, 5217.869553261123, 5227.921581176285, 5241.161414173714, 5241.955637301456, 5244.895102098013, 5521.135205356267, 5522.696251706115, 5523.696196709139, 5535.972320138373, 5536.972315138399, 5151.484851514893, 5418.810341638103, 5433.8369848904595, 5446.673199608036, 5452.236686863842, 2956.4678357895787, 2965.747911427553, 2984.9552256716165, 2992.431438026768, 3003.5794988701164, 5617.747201375948, 5714.79998200061, 5764.337101233328, 5774.220480235199, 5795.159701843293, 5473.31583552056, 5589.630540517518, 5611.6352437091455, 5658.490735833795, 5669.0, 5654.632448890891, 5669.744861481243, 5687.289088863892, 5692.1461780733225, 5702.0, 5374.381946076252, 5401.648892821954, 5490.890182196414, 5508.779648814003, 5518.613697041169, 5433.891322173614, 5441.83674489766, 5443.040505418126, 5487.259220005249, 5494.450554944474, 5415.698105742062, 5678.545716342765, 5681.857953551194, 5696.686682232517, 5718.771249149988, 3881.243157584244, 3902.434147048605, 3902.765834049966, 3909.804509774443, 3946.6053394660303, 5472.589555783412, 5529.838733865933, 5551.611387202857, 5564.4991950724625, 5587.189857470726, 5254.028004818968, 5425.457454254543, 5448.085274378189, 5464.699441530754, 5562.805301814417, 5519.227308176778, 5549.472800084147, 5552.028395030773, 5563.693996830213, 5565.749541270734, 5239.318888544617, 5337.412884582615, 5379.67721936685, 5516.806911758069, 5550.4449555045785, 5621.690807005491, 5635.0, 5637.802676906289, 5641.12562552805, 5645.830625081254, 5451.754671039892, 5495.587830912617, 5503.449655034465, 5503.917441238465, 5529.917051244154], "value": 4239.92545613191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.7993601919424, 759.8746206875866, 790.746960972489, 792.6829268292682, 811.2414892075911, 15017.0, 15202.163880986542, 16231.107289099094, 16261.593460163502, 16269.430569930055, 13914.373853176607, 14036.157830530175, 14057.15657060577, 14080.225587592704, 14099.08355956862, 669.9330066993286, 787.9953059848682, 788.0582703669118, 789.5223389849144, 789.8617741895159, 683.1904193530683, 781.316348195329, 787.1302211056785, 797.8045378882182, 805.6495424490336, 799.7760627024443, 801.7514570483169, 801.791534201109, 802.2819576479047, 803.7186984555417, 713.2831504338159, 798.9560574168419, 799.1808396393685, 799.7640695994695, 804.1516200408566, 535.1330844032653, 603.4086595136747, 605.0953824033098, 620.4756980351596, 621.0839012456636, 15127.621809454742, 15160.772588411182, 15162.772558411632, 15166.165860877647, 15173.924130379388, 13361.131526450847, 13518.662033449144, 13662.590122296348, 13757.449702011907, 13842.446302147902, 11571.826422603668, 11596.246243994114, 11596.59411920587, 11720.062395008465, 12276.693082672915, 4120.423140760296, 4155.210510003089, 4207.410962465257, 4277.529471758104, 4294.484661840599, 68158.9999999995, 70135.29864701339, 70143.0, 70261.08172427933, 70316.29683703149, 10668.413237271869, 10812.729681758019, 10828.566857325777, 10943.343399395902, 10949.397783122005, 20568.382948511568, 20816.58366832685, 21079.789202108088, 21195.68206476904, 21213.257535986166, 7381.261873812683, 7566.2433756625, 7664.6934122635585, 7667.8849817252785, 7938.24586664266, 4171.33258678616, 4228.513720922072, 4233.7671428071135, 4280.72175308604, 4323.0705398339505, 3179.300553878143, 3241.0600925731746, 3272.051105179519, 3272.2310257089566, 3275.7870738402403, 554.9750261238254, 558.3857756467934, 566.2497191221648, 572.9312482502044, 579.9072148456311, 613.5242515251474, 626.786892456567, 651.8956966885276, 660.5112216959416, 660.9206895172514, 8855.557222138867, 8918.464892106495, 9354.391964522285, 9408.719032840041, 9732.934125750508, 561.1806762127259, 570.1533223163599, 590.5659340384814, 625.2902955145942, 637.9202599675041, 4464.419625448736, 4501.265545825709, 4545.227311357077, 4578.6794924355645, 4585.72485650862, 76085.61957190179, 77747.0, 77984.22015779883, 79493.60253198813, 79558.0, 68758.31241687619, 69471.65264173647, 69641.65179174072, 70097.29902700908, 72805.63597182086, 61371.69314153401, 62084.0, 62331.688341558, 62568.37431625625, 63262.0, 8161.551114688749, 8392.0, 8564.614592343234, 8603.82792344162, 8680.088590697886, 36534.0, 40388.0, 41383.793081034404, 41718.374224386054, 42717.3690236321, 49941.50058499514, 55070.44929550653, 56145.0, 57203.0, 59277.40722592892, 10491.318064325795, 10682.519286631965, 10870.728231793952, 10953.671389858317, 11005.17461190398, 10454.790904181722, 10595.205359597907, 10851.45742712877, 11033.44832758375, 11231.887681123411, 11530.250533715282, 11629.418529073682, 11871.881281187423, 12478.251304921734, 12543.87456125427, 12436.813447798471, 13519.188848668718, 13630.386632601754, 14020.929895350459, 14212.431502739775, 13612.251326177155, 13911.095778774346, 13928.442862285801, 14665.633359166106, 14789.926050369679, 11324.37715925632, 11370.578677665291, 11441.771164576829, 11518.366489842803, 12219.755604887674, 11803.881961180277, 11879.168458208189, 12058.638240852788, 12086.112434492392, 12124.0], "value": 6883.363021853245, "unit": "score"}], "name": "dromaeo_css", "value": 6891.049307664175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 114.0, 113.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 126.0, 160.0, 127.0, 125.0, 126.0, 128.0, 138.0, 123.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 162.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 115.0, 76.0, 75.0, 76.0, 76.0, 95.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 103.0, 84.0, 84.0, 84.0, 95.0, 84.0, 83.0, 102.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 65.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 65.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 81.0, 90.0, 82.0, 81.0, 83.0, 81.0, 81.0, 88.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 147.0, 150.0, 130.0, 130.0, 132.0, 130.0, 184.0, 143.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 173.0, 171.0, 167.0, 173.0, 167.0, 171.0, 173.0, 167.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 65.0, 69.0, 65.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1525.8, "alertThreshold": 2.0}]} 00:25:32 INFO - Return code: 0 00:25:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:25:32 INFO - # TBPL SUCCESS # 00:25:32 INFO - Running post-action listener: _resource_record_post_action 00:25:32 INFO - [mozharness: 2016-12-15 08:25:32.860530Z] Finished run-tests step (success) 00:25:32 INFO - Running post-run listener: _resource_record_post_run 00:25:32 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392650752; Read time: 8; Write time: 221712 00:25:32 INFO - TinderboxPrint: CPU usage
13.2% 00:25:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 00:25:32 INFO - TinderboxPrint: I/O write bytes / time
392,650,752 / 221,712 00:25:32 INFO - TinderboxPrint: CPU idle
8,302.6 (86.8%) 00:25:32 INFO - TinderboxPrint: CPU user
1,211.8 (12.7%) 00:25:32 INFO - TinderboxPrint: Swap in / out
0 / 0 00:25:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104128512; Read time: 0; Write time: 68064 00:25:32 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288522240; Read time: 8; Write time: 153648 00:25:33 INFO - Running post-run listener: _upload_blobber_files 00:25:33 INFO - Blob upload gear active. 00:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:25:33 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 00:25:33 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:25:33 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:25:33 INFO - (blobuploader) - INFO - Open directory for files ... 00:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:37 INFO - (blobuploader) - INFO - Done attempting. 00:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:38 INFO - (blobuploader) - INFO - Done attempting. 00:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:39 INFO - (blobuploader) - INFO - Done attempting. 00:25:39 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:39 INFO - Return code: 0 00:25:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da506c8bd1d2de0f3159acab2116c409592ffbb0f704cc11345485c4d1dce105f79e445fb19af15edbf5fd82318e1729c5146eb91ec2c1e4f8013d45509acce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b99bba7517a8d7a957bcefb5bcc07a64df9b9048aceadfa1996b9dd1f228dd670b26cc5eaac8aa1dce7c565d3eb6e1520dba25e0a0a66e51ef19db074a2468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e09aa8663261b61499d86e586e6a3e3def6f9b092637640c6dce62d754710616e18e5b842233692b1bd549988b5d03d06c75686cd604f9bdd6ce1c1e0b1744a"} 00:25:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:39 INFO - Contents: 00:25:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da506c8bd1d2de0f3159acab2116c409592ffbb0f704cc11345485c4d1dce105f79e445fb19af15edbf5fd82318e1729c5146eb91ec2c1e4f8013d45509acce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b99bba7517a8d7a957bcefb5bcc07a64df9b9048aceadfa1996b9dd1f228dd670b26cc5eaac8aa1dce7c565d3eb6e1520dba25e0a0a66e51ef19db074a2468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e09aa8663261b61499d86e586e6a3e3def6f9b092637640c6dce62d754710616e18e5b842233692b1bd549988b5d03d06c75686cd604f9bdd6ce1c1e0b1744a"} 00:25:39 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:39 INFO - Copying logs to upload dir... 00:25:39 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.872586 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-15 00:25:39.129245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 00:25:39.133075) ========= 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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da506c8bd1d2de0f3159acab2116c409592ffbb0f704cc11345485c4d1dce105f79e445fb19af15edbf5fd82318e1729c5146eb91ec2c1e4f8013d45509acce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b99bba7517a8d7a957bcefb5bcc07a64df9b9048aceadfa1996b9dd1f228dd670b26cc5eaac8aa1dce7c565d3eb6e1520dba25e0a0a66e51ef19db074a2468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e09aa8663261b61499d86e586e6a3e3def6f9b092637640c6dce62d754710616e18e5b842233692b1bd549988b5d03d06c75686cd604f9bdd6ce1c1e0b1744a"} build_url:https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/CkVC67CITDqcc8RiTVNBBw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da506c8bd1d2de0f3159acab2116c409592ffbb0f704cc11345485c4d1dce105f79e445fb19af15edbf5fd82318e1729c5146eb91ec2c1e4f8013d45509acce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b99bba7517a8d7a957bcefb5bcc07a64df9b9048aceadfa1996b9dd1f228dd670b26cc5eaac8aa1dce7c565d3eb6e1520dba25e0a0a66e51ef19db074a2468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e09aa8663261b61499d86e586e6a3e3def6f9b092637640c6dce62d754710616e18e5b842233692b1bd549988b5d03d06c75686cd604f9bdd6ce1c1e0b1744a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 00:25:39.158681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:25:39.159009) ========= 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=41a7e32711b8e08598a63237000001d6-1481787815.419608-1700507102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 00:25:39.243365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 00:25:39.243686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 00:25:39.244030) ========= ========= Total master_lag: 0.17 =========