builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1481107852.62 results: success (0) buildid: 20161207020338 builduid: 6e4685cf06084f25a25249df5d4a0783 revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.619941) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.620435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.620789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.647365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.647682) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 02:50:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-12-07 02:50:52 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.830199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.830567) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015569 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.880290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:52.880693) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 02:50:52,937 truncating revision to first 12 chars 2016-12-07 02:50:52,937 Setting DEBUG logging. 2016-12-07 02:50:52,937 attempt 1/10 2016-12-07 02:50:52,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/983a7399df86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 02:50:53,240 unpacking tar archive at: graphics-983a7399df86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:53.530239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:53.530606) ========= script_repo_revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:53.531065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:53.531343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 02:50:53.541936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-07 02:50:53.542373) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:50:53 INFO - MultiFileLogger online at 20161207 02:50:53 in /builds/slave/test 02:50:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 02:50:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:53 INFO - {'append_to_log': False, 02:50:53 INFO - 'base_work_dir': '/builds/slave/test', 02:50:53 INFO - 'blob_upload_branch': 'Graphics', 02:50:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:53 INFO - 'branch': 'Graphics', 02:50:53 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:53 INFO - 'config_files': ('talos/linux_config.py',), 02:50:53 INFO - 'default_actions': ('clobber', 02:50:53 INFO - 'read-buildbot-config', 02:50:53 INFO - 'download-and-extract', 02:50:53 INFO - 'populate-webroot', 02:50:53 INFO - 'create-virtualenv', 02:50:53 INFO - 'install', 02:50:53 INFO - 'run-tests'), 02:50:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:53 INFO - 'download_minidump_stackwalk': True, 02:50:53 INFO - 'download_symbols': 'ondemand', 02:50:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:53 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:53 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:53 INFO - 'installer_path': 'installer.exe', 02:50:53 INFO - 'log_level': 'info', 02:50:53 INFO - 'log_name': 'talos', 02:50:53 INFO - 'log_to_console': True, 02:50:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:50:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:50:53 INFO - 'opt_config_files': (), 02:50:53 INFO - 'pip_index': False, 02:50:53 INFO - 'sps_profile': False, 02:50:53 INFO - 'sps_profile_interval': 0, 02:50:53 INFO - 'suite': 'dromaeojs', 02:50:53 INFO - 'system_bits': '32', 02:50:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:53 INFO - 'title': 'talos-linux64-ix-013', 02:50:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:53 INFO - 'use_talos_json': True, 02:50:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:53 INFO - 'work_dir': 'build'} 02:50:53 INFO - [mozharness: 2016-12-07 10:50:53.797292Z] Running clobber step. 02:50:53 INFO - Running pre-action listener: _resource_record_pre_action 02:50:53 INFO - Running main action method: clobber 02:50:53 INFO - rmtree: /builds/slave/test/build 02:50:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:54 INFO - Running post-action listener: _resource_record_post_action 02:50:54 INFO - [mozharness: 2016-12-07 10:50:54.212905Z] Finished clobber step (success) 02:50:54 INFO - [mozharness: 2016-12-07 10:50:54.213004Z] Running read-buildbot-config step. 02:50:54 INFO - Running pre-action listener: _resource_record_pre_action 02:50:54 INFO - Running main action method: read_buildbot_config 02:50:54 INFO - Using buildbot properties: 02:50:54 INFO - { 02:50:54 INFO - "project": "", 02:50:54 INFO - "product": "firefox", 02:50:54 INFO - "script_repo_revision": "default", 02:50:54 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 02:50:54 INFO - "repository": "", 02:50:54 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 02:50:54 INFO - "buildid": "20161207020338", 02:50:54 INFO - "pgo_build": "False", 02:50:54 INFO - "basedir": "/builds/slave/test", 02:50:54 INFO - "buildnumber": 22, 02:50:54 INFO - "slavename": "talos-linux64-ix-013", 02:50:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:50:54 INFO - "platform": "ubuntu64_hw", 02:50:54 INFO - "scheduler": "tests-graphics-linux64-talos", 02:50:54 INFO - "branch": "graphics", 02:50:54 INFO - "repo_path": "projects/graphics", 02:50:54 INFO - "revision": "983a7399df86ff30a8a8b45f44ccdc6727ac4477", 02:50:54 INFO - "stage_platform": "linux64", 02:50:54 INFO - "builduid": "6e4685cf06084f25a25249df5d4a0783", 02:50:54 INFO - "slavebuilddir": "test" 02:50:54 INFO - } 02:50:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:50:54 INFO - Running post-action listener: _resource_record_post_action 02:50:54 INFO - [mozharness: 2016-12-07 10:50:54.215421Z] Finished read-buildbot-config step (success) 02:50:54 INFO - [mozharness: 2016-12-07 10:50:54.215511Z] Running download-and-extract step. 02:50:54 INFO - Running pre-action listener: _resource_record_pre_action 02:50:54 INFO - Running main action method: download_and_extract 02:50:54 INFO - mkdir: /builds/slave/test/build/tests 02:50:54 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')]} 02:50:54 INFO - trying https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:50:54 INFO - Downloading https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/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 02:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/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 02:50:54 INFO - Downloaded 1361 bytes. 02:50:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:50:54 INFO - Using the following test package requirements: 02:50:54 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:50:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:50:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'jsshell-linux-x86_64.zip'], 02:50:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:50:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:50:54 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:50:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:50:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:50:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:50:55 INFO - Expected file size: 20218977 02:50:55 INFO - Obtained file size: 20218977 02:50:59 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 02:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:51:00 INFO - Expected file size: 20218977 02:51:00 INFO - Obtained file size: 20218977 02:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:51:06 INFO - Expected file size: 14409734 02:51:06 INFO - Obtained file size: 14409734 02:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:06 INFO - trying https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:51:06 INFO - Downloading https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/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 02:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/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 02:51:07 INFO - Downloaded 55719603 bytes. 02:51:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:51:07 INFO - mkdir: /builds/slave/test/properties 02:51:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:07 INFO - Contents: 02:51:07 INFO - build_url:https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:51:08 INFO - Running post-action listener: _resource_record_post_action 02:51:08 INFO - Running post-action listener: set_extra_try_arguments 02:51:08 INFO - [mozharness: 2016-12-07 10:51:08.065808Z] Finished download-and-extract step (success) 02:51:08 INFO - [mozharness: 2016-12-07 10:51:08.066035Z] Running populate-webroot step. 02:51:08 INFO - Running pre-action listener: _resource_record_pre_action 02:51:08 INFO - Running main action method: populate_webroot 02:51:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:08 INFO - '--tppagecycles', 02:51:08 INFO - '7'], 02:51:08 INFO - 'tests': ['tsvgm']}}, 02:51:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:51:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:51:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:51:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['damp', 'tps']}, 02:51:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'tests': ['damp', 'tps']}, 02:51:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['dromaeo_dom']}, 02:51:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['basic_compositor_video']}, 02:51:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:51:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['a11yr', 02:51:08 INFO - 'ts_paint', 02:51:08 INFO - 'tpaint', 02:51:08 INFO - 'sessionrestore', 02:51:08 INFO - 'sessionrestore_no_auto_restore', 02:51:08 INFO - 'tabpaint']}, 02:51:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['tsvgx', 02:51:08 INFO - 'tsvgr_opacity', 02:51:08 INFO - 'tart', 02:51:08 INFO - 'tscrollx', 02:51:08 INFO - 'cart', 02:51:08 INFO - 'tsvg_static']}, 02:51:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:51:08 INFO - 'tsvgr_opacity', 02:51:08 INFO - 'tart', 02:51:08 INFO - 'tscrollx', 02:51:08 INFO - 'cart', 02:51:08 INFO - 'tsvg_static']}, 02:51:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'talos_options': ['--disable-e10s'], 02:51:08 INFO - 'tests': ['tp5o']}, 02:51:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:51:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'talos_options': ['--disable-e10s', 02:51:08 INFO - '--xperf_path', 02:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:08 INFO - 'tests': ['tp5n']}, 02:51:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:51:08 INFO - 'talos_options': ['--xperf_path', 02:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:08 INFO - 'tests': ['tp5n']}}, 02:51:08 INFO - 'talos.zip': {'path': '', 02:51:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:08 INFO - Running post-action listener: _resource_record_post_action 02:51:08 INFO - [mozharness: 2016-12-07 10:51:08.083450Z] Finished populate-webroot step (success) 02:51:08 INFO - [mozharness: 2016-12-07 10:51:08.083539Z] Running create-virtualenv step. 02:51:08 INFO - Running pre-action listener: _resource_record_pre_action 02:51:08 INFO - Running main action method: create_virtualenv 02:51:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:08 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 02:51:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:08 INFO - Using real prefix '/usr' 02:51:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:10 INFO - Installing pip.................done. 02:51:10 INFO - Return code: 0 02:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:51:11 INFO - Reading from file tmpfile_stdout 02:51:11 INFO - Output received: 02:51:11 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) 02:51:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:11 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')]} 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 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')]} 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:11 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 02:51:11 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 02:51:11 INFO - Using env: {'DISPLAY': ':0', 02:51:11 INFO - 'HOME': '/home/cltbld', 02:51:11 INFO - 'LANG': 'en_US.UTF-8', 02:51:11 INFO - 'LANGUAGE': 'en_US:en', 02:51:11 INFO - 'LOGNAME': 'cltbld', 02:51:11 INFO - 'MAIL': '/var/mail/cltbld', 02:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:11 INFO - 'MOZ_NO_REMOTE': '1', 02:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:11 INFO - 'NO_EM_RESTART': '1', 02:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:11 INFO - 'PWD': '/builds/slave/test', 02:51:11 INFO - 'SHELL': '/bin/bash', 02:51:11 INFO - 'SHLVL': '1', 02:51:11 INFO - 'TERM': 'linux', 02:51:11 INFO - 'TMOUT': '86400', 02:51:11 INFO - 'USER': 'cltbld', 02:51:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:11 INFO - '_': '/tools/buildbot/bin/python'} 02:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:11 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 02:51:11 INFO - Cleaning up... 02:51:11 INFO - Return code: 0 02:51:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:51:11 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')]} 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 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')]} 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:11 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 02:51:11 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 02:51:11 INFO - Using env: {'DISPLAY': ':0', 02:51:11 INFO - 'HOME': '/home/cltbld', 02:51:11 INFO - 'LANG': 'en_US.UTF-8', 02:51:11 INFO - 'LANGUAGE': 'en_US:en', 02:51:11 INFO - 'LOGNAME': 'cltbld', 02:51:11 INFO - 'MAIL': '/var/mail/cltbld', 02:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:11 INFO - 'MOZ_NO_REMOTE': '1', 02:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:11 INFO - 'NO_EM_RESTART': '1', 02:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:11 INFO - 'PWD': '/builds/slave/test', 02:51:11 INFO - 'SHELL': '/bin/bash', 02:51:11 INFO - 'SHLVL': '1', 02:51:11 INFO - 'TERM': 'linux', 02:51:11 INFO - 'TMOUT': '86400', 02:51:11 INFO - 'USER': 'cltbld', 02:51:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:11 INFO - '_': '/tools/buildbot/bin/python'} 02:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:12 INFO - Downloading/unpacking psutil>=3.1.1 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:14 INFO - Installing collected packages: psutil 02:51:14 INFO - Running setup.py install for psutil 02:51:15 INFO - building 'psutil._psutil_linux' extension 02:51:15 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 02:51:15 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 02:51:16 INFO - building 'psutil._psutil_posix' extension 02:51: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 02:51: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 02:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:16 INFO - Successfully installed psutil 02:51:16 INFO - Cleaning up... 02:51:16 INFO - Return code: 0 02:51:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:16 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:16 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 02:51:16 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 02:51:16 INFO - Using env: {'DISPLAY': ':0', 02:51:16 INFO - 'HOME': '/home/cltbld', 02:51:16 INFO - 'LANG': 'en_US.UTF-8', 02:51:16 INFO - 'LANGUAGE': 'en_US:en', 02:51:16 INFO - 'LOGNAME': 'cltbld', 02:51:16 INFO - 'MAIL': '/var/mail/cltbld', 02:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:16 INFO - 'MOZ_NO_REMOTE': '1', 02:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:16 INFO - 'NO_EM_RESTART': '1', 02:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:16 INFO - 'PWD': '/builds/slave/test', 02:51:16 INFO - 'SHELL': '/bin/bash', 02:51:16 INFO - 'SHLVL': '1', 02:51:16 INFO - 'TERM': 'linux', 02:51:16 INFO - 'TMOUT': '86400', 02:51:16 INFO - 'USER': 'cltbld', 02:51:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:16 INFO - '_': '/tools/buildbot/bin/python'} 02:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:51:16 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 02:51:16 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 02:51:16 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 02:51:16 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 02:51:16 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 02:51:16 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 02:51:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:51:18 INFO - Installing collected packages: mozsystemmonitor 02:51:18 INFO - Running setup.py install for mozsystemmonitor 02:51:18 INFO - Successfully installed mozsystemmonitor 02:51:18 INFO - Cleaning up... 02:51:18 INFO - Return code: 0 02:51:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:51:18 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')]} 02:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 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')]} 02:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:18 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 02:51:18 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 02:51:18 INFO - Using env: {'DISPLAY': ':0', 02:51:18 INFO - 'HOME': '/home/cltbld', 02:51:18 INFO - 'LANG': 'en_US.UTF-8', 02:51:18 INFO - 'LANGUAGE': 'en_US:en', 02:51:18 INFO - 'LOGNAME': 'cltbld', 02:51:18 INFO - 'MAIL': '/var/mail/cltbld', 02:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:18 INFO - 'MOZ_NO_REMOTE': '1', 02:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:18 INFO - 'NO_EM_RESTART': '1', 02:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:18 INFO - 'PWD': '/builds/slave/test', 02:51:18 INFO - 'SHELL': '/bin/bash', 02:51:18 INFO - 'SHLVL': '1', 02:51:18 INFO - 'TERM': 'linux', 02:51:18 INFO - 'TMOUT': '86400', 02:51:18 INFO - 'USER': 'cltbld', 02:51:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:18 INFO - '_': '/tools/buildbot/bin/python'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 INFO - Downloading/unpacking jsonschema==2.5.1 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:21 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:21 INFO - warning: no files found matching '*.txt' 02:51:21 INFO - no previously-included directories found matching 'build' 02:51:21 INFO - no previously-included directories found matching 'dist' 02:51:21 INFO - no previously-included directories found matching '.git*' 02:51:21 INFO - Installing collected packages: jsonschema, functools32 02:51:21 INFO - Running setup.py install for functools32 02:51:21 INFO - warning: no files found matching '*.txt' 02:51:21 INFO - no previously-included directories found matching 'build' 02:51:21 INFO - no previously-included directories found matching 'dist' 02:51:21 INFO - no previously-included directories found matching '.git*' 02:51:21 INFO - Successfully installed jsonschema functools32 02:51:21 INFO - Cleaning up... 02:51:21 INFO - Return code: 0 02:51:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:21 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 02:51:21 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 02:51:21 INFO - Using env: {'DISPLAY': ':0', 02:51:21 INFO - 'HOME': '/home/cltbld', 02:51:21 INFO - 'LANG': 'en_US.UTF-8', 02:51:21 INFO - 'LANGUAGE': 'en_US:en', 02:51:21 INFO - 'LOGNAME': 'cltbld', 02:51:21 INFO - 'MAIL': '/var/mail/cltbld', 02:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:21 INFO - 'MOZ_NO_REMOTE': '1', 02:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:21 INFO - 'NO_EM_RESTART': '1', 02:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:21 INFO - 'PWD': '/builds/slave/test', 02:51:21 INFO - 'SHELL': '/bin/bash', 02:51:21 INFO - 'SHLVL': '1', 02:51:21 INFO - 'TERM': 'linux', 02:51:21 INFO - 'TMOUT': '86400', 02:51:21 INFO - 'USER': 'cltbld', 02:51:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:21 INFO - '_': '/tools/buildbot/bin/python'} 02:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:51:21 INFO - Cleaning up... 02:51:21 INFO - Return code: 0 02:51:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:21 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 02:51:21 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 02:51:21 INFO - Using env: {'DISPLAY': ':0', 02:51:21 INFO - 'HOME': '/home/cltbld', 02:51:21 INFO - 'LANG': 'en_US.UTF-8', 02:51:21 INFO - 'LANGUAGE': 'en_US:en', 02:51:21 INFO - 'LOGNAME': 'cltbld', 02:51:21 INFO - 'MAIL': '/var/mail/cltbld', 02:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:21 INFO - 'MOZ_NO_REMOTE': '1', 02:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:21 INFO - 'NO_EM_RESTART': '1', 02:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:21 INFO - 'PWD': '/builds/slave/test', 02:51:21 INFO - 'SHELL': '/bin/bash', 02:51:21 INFO - 'SHLVL': '1', 02:51:21 INFO - 'TERM': 'linux', 02:51:21 INFO - 'TMOUT': '86400', 02:51:21 INFO - 'USER': 'cltbld', 02:51:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:21 INFO - '_': '/tools/buildbot/bin/python'} 02:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:24 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:25 INFO - Downloading docopt-0.6.1.tar.gz 02:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:25 INFO - Running setup.py install for blobuploader 02:51:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:25 INFO - Running setup.py install for requests 02:51:25 INFO - Running setup.py install for docopt 02:51:25 INFO - Successfully installed blobuploader requests docopt 02:51:25 INFO - Cleaning up... 02:51:25 INFO - Return code: 0 02:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51: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 02:51: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 02:51:25 INFO - Using env: {'DISPLAY': ':0', 02:51:25 INFO - 'HOME': '/home/cltbld', 02:51:25 INFO - 'LANG': 'en_US.UTF-8', 02:51:25 INFO - 'LANGUAGE': 'en_US:en', 02:51:25 INFO - 'LOGNAME': 'cltbld', 02:51:25 INFO - 'MAIL': '/var/mail/cltbld', 02:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:25 INFO - 'MOZ_NO_REMOTE': '1', 02:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:25 INFO - 'NO_EM_RESTART': '1', 02:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:25 INFO - 'PWD': '/builds/slave/test', 02:51:25 INFO - 'SHELL': '/bin/bash', 02:51:25 INFO - 'SHLVL': '1', 02:51:25 INFO - 'TERM': 'linux', 02:51:25 INFO - 'TMOUT': '86400', 02:51:25 INFO - 'USER': 'cltbld', 02:51:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:25 INFO - '_': '/tools/buildbot/bin/python'} 02:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:25 INFO - Running setup.py (path:/tmp/pip-ZGQISe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:25 INFO - Running setup.py (path:/tmp/pip-f6KXre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:25 INFO - Running setup.py (path:/tmp/pip-LIm2Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:26 INFO - Running setup.py (path:/tmp/pip-N6jQ1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:26 INFO - Running setup.py (path:/tmp/pip-UWwCWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:26 INFO - Running setup.py (path:/tmp/pip-wo2rGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:26 INFO - Running setup.py (path:/tmp/pip-anpno2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:26 INFO - Running setup.py (path:/tmp/pip-xsbWAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:26 INFO - Running setup.py (path:/tmp/pip-XZwwqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:26 INFO - Running setup.py (path:/tmp/pip-cxDgJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:26 INFO - Running setup.py (path:/tmp/pip-en7jAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:26 INFO - Running setup.py (path:/tmp/pip-PjTeun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:26 INFO - Running setup.py (path:/tmp/pip-uAtZCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:26 INFO - Running setup.py (path:/tmp/pip-kp01MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:26 INFO - Running setup.py (path:/tmp/pip-pfQJ2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:26 INFO - Running setup.py (path:/tmp/pip-LuS71M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:26 INFO - Running setup.py (path:/tmp/pip-2kDBRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:26 INFO - Running setup.py install for manifestparser 02:51:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for mozcrash 02:51:27 INFO - Running setup.py install for mozdebug 02:51:27 INFO - Running setup.py install for mozdevice 02:51:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for mozfile 02:51:27 INFO - Running setup.py install for mozhttpd 02:51:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for mozinfo 02:51:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for mozInstall 02:51:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for mozleak 02:51:27 INFO - Running setup.py install for mozlog 02:51:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:27 INFO - Running setup.py install for moznetwork 02:51:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Running setup.py install for mozprocess 02:51:28 INFO - Running setup.py install for mozprofile 02:51:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Running setup.py install for mozrunner 02:51:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Running setup.py install for mozscreenshot 02:51:28 INFO - Running setup.py install for moztest 02:51:28 INFO - Running setup.py install for mozversion 02:51:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:28 INFO - Cleaning up... 02:51:28 INFO - Return code: 0 02:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:28 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:28 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 02:51:28 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 02:51:28 INFO - Using env: {'DISPLAY': ':0', 02:51:28 INFO - 'HOME': '/home/cltbld', 02:51:28 INFO - 'LANG': 'en_US.UTF-8', 02:51:28 INFO - 'LANGUAGE': 'en_US:en', 02:51:28 INFO - 'LOGNAME': 'cltbld', 02:51:28 INFO - 'MAIL': '/var/mail/cltbld', 02:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:28 INFO - 'MOZ_NO_REMOTE': '1', 02:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:28 INFO - 'NO_EM_RESTART': '1', 02:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:28 INFO - 'PWD': '/builds/slave/test', 02:51:28 INFO - 'SHELL': '/bin/bash', 02:51:28 INFO - 'SHLVL': '1', 02:51:28 INFO - 'TERM': 'linux', 02:51:28 INFO - 'TMOUT': '86400', 02:51:28 INFO - 'USER': 'cltbld', 02:51:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:28 INFO - '_': '/tools/buildbot/bin/python'} 02:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:28 INFO - Running setup.py (path:/tmp/pip-BCRGNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:29 INFO - Running setup.py (path:/tmp/pip-5FCTU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:29 INFO - Running setup.py (path:/tmp/pip-MqobKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:29 INFO - Running setup.py (path:/tmp/pip-SV1ff1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:29 INFO - Running setup.py (path:/tmp/pip-0cDdfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:29 INFO - Running setup.py (path:/tmp/pip-Nkh_CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:29 INFO - Running setup.py (path:/tmp/pip-X6KmkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:29 INFO - Running setup.py (path:/tmp/pip-Nj9PNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51: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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:29 INFO - Running setup.py (path:/tmp/pip-ebgiJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:29 INFO - Running setup.py (path:/tmp/pip-sOT8vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:29 INFO - Running setup.py (path:/tmp/pip-spT92M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:29 INFO - Running setup.py (path:/tmp/pip-YScyog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:29 INFO - Running setup.py (path:/tmp/pip-CGPlfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:29 INFO - Running setup.py (path:/tmp/pip-AtGS4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:29 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)) 02:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:29 INFO - Running setup.py (path:/tmp/pip-WXV9gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51: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)) 02:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:30 INFO - Running setup.py (path:/tmp/pip-K0EhZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51: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)) 02:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:30 INFO - Running setup.py (path:/tmp/pip-pTCPnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51: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)) 02:51: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)) 02:51: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)) 02:51: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)) 02:51: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)) 02:51: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)) 02:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:32 INFO - Downloading blessings-1.6.tar.gz 02:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:32 INFO - Installing collected packages: blessings 02:51:32 INFO - Running setup.py install for blessings 02:51:32 INFO - Successfully installed blessings 02:51:32 INFO - Cleaning up... 02:51:32 INFO - Return code: 0 02:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:32 INFO - Reading from file tmpfile_stdout 02:51:32 INFO - Current package versions: 02:51:32 INFO - argparse == 1.2.1 02:51:32 INFO - blessings == 1.6 02:51:32 INFO - blobuploader == 1.2.4 02:51:32 INFO - docopt == 0.6.1 02:51:32 INFO - functools32 == 3.2.3-2 02:51:32 INFO - jsonschema == 2.5.1 02:51:32 INFO - manifestparser == 1.1 02:51:32 INFO - mozInstall == 1.12 02:51:32 INFO - mozcrash == 1.0 02:51:32 INFO - mozdebug == 0.1 02:51:32 INFO - mozdevice == 0.49 02:51:32 INFO - mozfile == 1.2 02:51:32 INFO - mozhttpd == 0.7 02:51:32 INFO - mozinfo == 0.9 02:51:32 INFO - mozleak == 0.1 02:51:32 INFO - mozlog == 3.4 02:51:32 INFO - moznetwork == 0.27 02:51:32 INFO - mozprocess == 0.23 02:51:32 INFO - mozprofile == 0.28 02:51:32 INFO - mozrunner == 6.13 02:51:32 INFO - mozscreenshot == 0.1 02:51:32 INFO - mozsystemmonitor == 0.3 02:51:32 INFO - moztest == 0.7 02:51:32 INFO - mozversion == 1.4 02:51:32 INFO - psutil == 3.1.1 02:51:32 INFO - requests == 1.2.3 02:51:32 INFO - wsgiref == 0.1.2 02:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:32 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 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:32 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 02:51:32 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 02:51:32 INFO - Using env: {'DISPLAY': ':0', 02:51:32 INFO - 'HOME': '/home/cltbld', 02:51:32 INFO - 'LANG': 'en_US.UTF-8', 02:51:32 INFO - 'LANGUAGE': 'en_US:en', 02:51:32 INFO - 'LOGNAME': 'cltbld', 02:51:32 INFO - 'MAIL': '/var/mail/cltbld', 02:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:32 INFO - 'MOZ_NO_REMOTE': '1', 02:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:32 INFO - 'NO_EM_RESTART': '1', 02:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:32 INFO - 'PWD': '/builds/slave/test', 02:51:32 INFO - 'SHELL': '/bin/bash', 02:51:32 INFO - 'SHLVL': '1', 02:51:32 INFO - 'TERM': 'linux', 02:51:32 INFO - 'TMOUT': '86400', 02:51:32 INFO - 'USER': 'cltbld', 02:51:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:32 INFO - '_': '/tools/buildbot/bin/python'} 02:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 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)) 02:51:32 INFO - Cleaning up... 02:51:32 INFO - Return code: 0 02:51:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c4ac61e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', '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 02:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:32 INFO - Using env: {'DISPLAY': ':0', 02:51:32 INFO - 'HOME': '/home/cltbld', 02:51:32 INFO - 'LANG': 'en_US.UTF-8', 02:51:32 INFO - 'LANGUAGE': 'en_US:en', 02:51:32 INFO - 'LOGNAME': 'cltbld', 02:51:32 INFO - 'MAIL': '/var/mail/cltbld', 02:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:32 INFO - 'MOZ_NO_REMOTE': '1', 02:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:32 INFO - 'NO_EM_RESTART': '1', 02:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:32 INFO - 'PWD': '/builds/slave/test', 02:51:32 INFO - 'SHELL': '/bin/bash', 02:51:32 INFO - 'SHLVL': '1', 02:51:32 INFO - 'TERM': 'linux', 02:51:32 INFO - 'TMOUT': '86400', 02:51:32 INFO - 'USER': 'cltbld', 02:51:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:32 INFO - '_': '/tools/buildbot/bin/python'} 02:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:51:33 INFO - Cleaning up... 02:51:33 INFO - Return code: 0 02:51:33 INFO - Running post-action listener: _resource_record_post_action 02:51:33 INFO - Running post-action listener: _start_resource_monitoring 02:51:33 INFO - Starting resource monitoring. 02:51:33 INFO - [mozharness: 2016-12-07 10:51:33.183376Z] Finished create-virtualenv step (success) 02:51:33 INFO - [mozharness: 2016-12-07 10:51:33.184304Z] Running install step. 02:51:33 INFO - Running pre-action listener: _resource_record_pre_action 02:51:33 INFO - Running main action method: install 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:33 INFO - Reading from file tmpfile_stdout 02:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:33 INFO - Reading from file tmpfile_stdout 02:51:33 INFO - Output received: 02:51:33 INFO - Usage: mozinstall [options] installer 02:51:33 INFO - Options: 02:51:33 INFO - -h, --help show this help message and exit 02:51:33 INFO - -d DEST, --destination=DEST 02:51:33 INFO - Directory to install application into. [default: 02:51:33 INFO - "/builds/slave/test"] 02:51:33 INFO - --app=APP Application being installed. [default: firefox] 02:51:33 INFO - mkdir: /builds/slave/test/build/application 02:51: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'] 02:51: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 02:51:49 INFO - Reading from file tmpfile_stdout 02:51:49 INFO - Output received: 02:51:49 INFO - /builds/slave/test/build/application/firefox/firefox 02:51:49 INFO - Running post-action listener: _resource_record_post_action 02:51:49 INFO - [mozharness: 2016-12-07 10:51:49.513851Z] Finished install step (success) 02:51:49 INFO - [mozharness: 2016-12-07 10:51:49.514093Z] Running run-tests step. 02:51:49 INFO - Running pre-action listener: _resource_record_pre_action 02:51:49 INFO - Running main action method: run_tests 02:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:51:49 INFO - Python 2.7.3 02:51:49 INFO - Return code: 0 02:51:49 INFO - grabbing minidump binary from tooltool 02:51:49 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')]} 02:51:49 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 0x2106f20>, '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 0x2073c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2073f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:51:49 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 02:51:49 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 02:51:49 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 02:51:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:51:49 INFO - Return code: 0 02:51:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:51:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:51:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:51:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:51:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:51:49 INFO - Using env: {'DISPLAY': ':0', 02:51:49 INFO - 'HOME': '/home/cltbld', 02:51:49 INFO - 'LANG': 'en_US.UTF-8', 02:51:49 INFO - 'LANGUAGE': 'en_US:en', 02:51:49 INFO - 'LOGNAME': 'cltbld', 02:51:49 INFO - 'MAIL': '/var/mail/cltbld', 02:51:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:51:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:49 INFO - 'MOZ_NO_REMOTE': '1', 02:51:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:49 INFO - 'NO_EM_RESTART': '1', 02:51:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:49 INFO - 'PWD': '/builds/slave/test', 02:51:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:51:49 INFO - 'SHELL': '/bin/bash', 02:51:49 INFO - 'SHLVL': '1', 02:51:49 INFO - 'TERM': 'linux', 02:51:49 INFO - 'TMOUT': '86400', 02:51:49 INFO - 'USER': 'cltbld', 02:51:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542', 02:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:49 INFO - '_': '/tools/buildbot/bin/python'} 02:51:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:51:49 INFO - mozversion application_buildid: 20161207020338 02:51:49 INFO - mozversion application_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 02:51:49 INFO - mozversion application_display_name: Nightly 02:51:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:51:49 INFO - mozversion application_name: Firefox 02:51:49 INFO - mozversion application_remotingname: firefox 02:51:49 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 02:51:49 INFO - mozversion application_vendor: Mozilla 02:51:49 INFO - mozversion application_version: 53.0a1 02:51:49 INFO - mozversion platform_buildid: 20161207020338 02:51:49 INFO - mozversion platform_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 02:51:49 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 02:51:49 INFO - mozversion platform_version: 53.0a1 02:51:49 INFO - using testdate: 1481107909 02:51:49 INFO - actual date: 1481107909 02:51:49 INFO - starting webserver on 'localhost:43365' 02:51:49 INFO - SUITE-START | Running 2 tests 02:51:49 INFO - TEST-START | dromaeo_css 02:51:49 INFO - operating with platform_type : linux_ 02:51:49 INFO - Initialising browser for dromaeo_css test... 02:51:49 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTMye6f/profile http://localhost:43365/getInfo.html) 02:51:55 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 02:51:55 INFO - PROCESS | 3333 | colorDepth:24 02:51:55 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 02:51:55 INFO - PROCESS | 3333 | __metrics 02:51:56 INFO - PROCESS | 3333 | 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" 02:51:56 INFO - PROCESS | 3333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:57 INFO - PROCESS | 3333 | console.error: PushService: 02:51:57 INFO - PROCESS | 3333 | stateChangeProcessEnqueue: Error transitioning state 02:51:57 INFO - PROCESS | 3333 | UnknownError 02:51:58 INFO - TEST-INFO | 3333: exit 0 02:51:58 INFO - Browser initialized. 02:51:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:51:58 INFO - TEST-INFO | started process 3414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTMye6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:10 INFO - PROCESS | 3414 | RSS: Main: 173793280 02:52:10 INFO - PROCESS | 3414 | 02:53:01 INFO - PROCESS | 3414 | 1481107981792 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] 02:55:15 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43365/tests/dromaeo/cssquery-ext.html) 02:55:17 INFO - PROCESS | 3414 | RSS: Main: 390848512 02:55:17 INFO - PROCESS | 3414 | 02:58:20 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-ext.html (next: http://localhost:43365/tests/dromaeo/cssquery-jquery.html) 02:58:21 INFO - PROCESS | 3414 | RSS: Main: 289439744 02:58:21 INFO - PROCESS | 3414 | 03:01:23 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43365/tests/dromaeo/cssquery-mootools.html) 03:01:24 INFO - PROCESS | 3414 | RSS: Main: 222588928 03:01:24 INFO - PROCESS | 3414 | 03:04:26 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43365/tests/dromaeo/cssquery-prototype.html) 03:04:27 INFO - PROCESS | 3414 | RSS: Main: 225169408 03:04:27 INFO - PROCESS | 3414 | 03:07:30 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43365/tests/dromaeo/cssquery-yui.html) 03:07:30 INFO - PROCESS | 3414 | RSS: Main: 228167680 03:07:30 INFO - PROCESS | 3414 | 03:10:33 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:43365/tests/dromaeo/cssquery-yui.html (next: http://localhost:43365/tests/dromaeo/cssquery-dojo.html) 03:10:34 INFO - PROCESS | 3414 | RSS: Main: 320028672 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | __start_tp_report 03:10:34 INFO - PROCESS | 3414 | _x_x_mozilla_page_load 03:10:34 INFO - PROCESS | 3414 | _x_x_mozilla_page_load_details 03:10:34 INFO - PROCESS | 3414 | |i|pagename|runs| 03:10:34 INFO - PROCESS | 3414 | |0;dojo.html;2577.368544706547;2609.5433299172664;2618;2618.8297760645564;2636.1300770745643;4450.26570615848;4543.500214976359;4629.051044535866;4643.0481751240995;4646.814127434903;4556.726596404218;4563.498015218323;4572.519885412034;4573.428321459817;4588.220002599558;4169.833206671737;4192.140611174702;4199.580041995807;4220.388043733657;4226.1547690461875;4221.810018549173;4222.535521092677;4223.366495025755;4231.894202644943;4237.87286381409;4217.388478670591;4235.025944032875;4268.061026574149;4270.338097594862;4318.82724691012;4279.037216626265;4282.700210985232;4284.871453856389;4290.442242508485;4316.07204451043;4104.220198162339;4111.383292506118;4138.358554424069;4191.098913733532;4258.829646814123;4603.562661547147;4661.86014419568;4668.206404911173;4674.649401294916;4676.625869930397;4983.875403114915;4987.750612469362;4990.051890140898;5017.523335283142;5054.3176671149295;4799.904001919942;4826.276058591205;5034.588587007806;5040.697558146523;5089.05852417304;4607.769611519444;4619.214733495314;4650.279206722963;4657.4876763555985;4724.102420540086;5093.694378337312;5099.082165210223;5107.310513080686;5108.642395032312;5144.331236939249;4855.417349918032;4857.1742803723455;4862.100511405401;4886.633502487328;4902.975485122623;4681.882952926204;4736.029114031615;4737.170995075848;4867.9269810952865;4898.069366820293;4871.415430148334;4884.12085824555;4904.55858972687;4920.163572192736;4925.261210818334;4835.927461088087;4875.122477953932;4881.926771098437;4889.584385327287;4934.802607895644;4080.235707270622;4111.321631930698;4141.937870931938;4249.383839343278;4302.053548219386;3674.375356189454;3677.9080522987138;3684.6683798458266;3702.648248416396;3739.383001804726;4203.6637069034405;4205.894852628709;4211.810468528924;4214.388913607571;4249.256380133526;4803.615710743132;4915.287283343967;4915.827946021944;4921.8523444296725;4961.503849615082;4154.709170358046;4168.936921085165;4190.769507677046;4240.342746874239;4248.893777655583;4516.954830451719;4519.954800452019;4523.932141017887;4533.070720502289;4553.2942393929;4585.4726706427855;4588.7246765194195;4615.907681846412;4627.958709290383;4661.510541393241;4790.113828941657;4861.756912154449;4862.902741945212;4924.064427758714;4926.556609905126;4467.2405691033255;4501.054778496552;4512.593866552026;4513.75174365413;4515.774211289357;4774.069056533943;4775.044991001744;4775.737334446639;4777.355057067251;4781.067691800065;4835.927461088017;4838.371011768448;4840.128776820206;4840.6127509799835;4841.612670986242;4682.0869930364615;4716.858494245178;4719.457262414729;4722.173619616622;4723.763811809327;4786.635808794616;4847.95152048475;4861.1979023460735;4896.436909755424;4932.8520144395725;4763;4771.1650461168465;4774.045190961752;4793.472718000948;4819.3012013258585;4872.9269060964825;4907.484714104968;4911.091448081973;4916.262560615936;4934.333864928189;4595.862124136282;4638.1187574360765;4642.814287428465;4698.9530104698515;4792.496787837227 03:10:34 INFO - PROCESS | 3414 | |1;ext.html;544.4609836262101;563.3718403979564;591.1015256809652;594.031728282899;595.2916029924389;36065.278694426095;37193;37480.250394992116;40833.38749918746;40900.590994090126;39194.608053919525;39622.40566391499;39672.80163599178;39781.40327895084;39911.201775964466;7273.490855640107;7300.4524660650395;7430.925690743077;7430.962845185766;7433.553986760785;9526.904730952705;9774.31579789415;9779.511024448784;10063.144632706191;10088.445135517544;9780.559874805615;9857.753556161082;9860.852087218698;9862.704118876445;9865.457399843006;9265.444073355553;9295.860562091573;9320.8601870972;9325.813483730355;9341.346105772598;9788.853167202426;9817.852732209023;9845.55694993727;9858.063483969012;9859.570362297498;37450.8127459361;37486;37531.24937501262;37742.622573774184;37779.4333085004;2806.593044008607;2868.727470890262;3147.7953932994283;3281.0976981330086;3356.7482438817187;27789.722102778916;28129;28202.576961345596;28254;28919.409432481207;3306.9173270668184;3438.0717206354393;3457.9308413831836;3467.254540273828;3521.031716278044;254474;256740.99999999814;257648;257720.7113964437;258431;50123.24815127776;50531.74734126379;50535;50550;50554.49445505571;52528.73735631297;52539.47460525346;52599;52632.21051684228;52660.46790641887;11252.099832013419;11757.941210293893;11825.053995680324;11831.940840295743;11843.34861582604;7803.609819509002;8007.399445041645;8012.958315418959;8192.918070819334;8624.137586241452;13405;14744.705105897821;14962.17708026069;15034.17312047848;15651.765223521656;5683.744231509592;5752.741126649311;5754.482096611325;5856.707164641751;5869.559783016291;680.034351221267;753.3069575990103;829.2619568583965;835.5488036460365;942.9339946203837;26212;28784.856075719486;29251.7074829249;30786.53820192699;31185.688143118277;896.3411892259185;921.4517362169498;926.3376685669779;929.3819609959437;1016.506994107857;13273.402696878471;14343.354549045318;14381.92809035948;14468.131912085308;14625.707485850224;339890;345857;346382;347840;348069;47288.763556182;47428;47657.80448541667;47800.7609961948;47812.28281575779;1012.9290949633455;1087.853139826129;1101.581399068349;1146.8681101673249;1185.8161984892183;24998.50002999966;27904.58143127814;28887.56668650014;29357.26606834846;29359.853200733858;35956;36341.27317453689;36374;36397.45403818892;36453.45319820258;302507;304038;305508;306064;306785;36780.81609591935;37483.81258093692;38073.61926380811;39886.2022759549;40219.19561608693;39427.60572394239;40209.39685904655;40211.79894100628;40306.395404069546;40321.39517907175;31117;31543;31943.68056319407;32149.35701286008;32265.677343226267;29586.852065739535;30837.383252334377;31435;32235.194120146247;34987.82506087453;32643.18392040218;32739.181520462178;33115.83442082774;33290;33423.665763342055;28646;30683.772649093786;30934.381312374077;31094.689053110083;31192.844035779675;23575.292741217792;23664.52670946537;23895.283141505784;24124;24246.75753242445 03:10:34 INFO - PROCESS | 3414 | |2;jquery.html;351.24657609427794;368.54852805313476;378.31336124933244;378.42857285498894;393.63981956509775;12440.191387559813;12518.874811251884;13293.534726284583;16255.268512916917;16931.322747090133;14509;15275.159866207354;16312.347506099743;16427.507174784747;16435.2604132814;4810.374651295327;5043.5965122790085;5280.392754833186;5317.202419637066;5400.378956420003;3420.9828950855335;5283.63014588979;5311.203319502086;5317.069512835258;5325.680459172462;3500;3820.0449887528116;3869.2648396804516;5702.173184888189;5778.335491418498;5798.449147330997;5812.157237200582;5815;5827.271591051119;5828.2131912191735;4967.3542439483;5083.822066227664;5109.821156259513;5120.743962801845;5129.692218466904;11807.350595717233;12122.939385303105;12252.632421027383;12270.38648067602;12290.078244131726;1813.4197056941784;1976.8912709800954;2123.819475344598;2303.689001984744;2402.0872068613817;8375.706850260272;8733.737987860375;9186.678466253716;9230;9321.766955826091;1642.531878414658;1721.5610019445087;1738.304678128746;1772.503698964292;1779.6885545029697;61010;65349.67325163344;65353.3464665352;65370;66408;9496;9562.28282878787;9651.034896510433;9892.505374731234;9976.301658883953;13076.019298552646;13104.934475327562;13113.475460981454;13123.343832808321;13211.801822972662;6068.666223357669;6111.358307377662;6281.183446152062;6329.651869147241;6359.650219237987;5544.473275038865;5631.465010823965;5681.0626246668835;5733.512651424592;5864.266966629171;3988.12261302513;4102.651274641689;4136;4152.522459917148;4261.083866968616;1779.1904683369037;1795.7306404039498;1810.8732388732662;1821.253286152671;1866.505376075341;742.4172024960488;752.1613401057781;777.700585274662;868.9659305426522;880.1858281089966;15412.614684632974;16073.678526429407;16141.515754527383;16180.19099045043;16802.57993550171;782.5891407011251;803.2770506544157;816.8938038055015;832.6669332267141;897.2821742605889;8676.262517685942;9080.545972701339;9162.679306224383;9313.860292095624;9451.952740236255;347696;348431;348798.81606511376;354437;356744;55872.72063639737;59698;72824;75665;77982;857.914208579137;869.9304055675531;871.1810897756089;873.4366333714719;877.8770972063916;14605;15220;15766.9211653941;15803.525894223192;16134.435294764628;34942.825285873405;36122.63877361193;36673.81663091668;36807.44788828223;37355.252894941405;46262.7686861577;48392.5160748388;49669.50330496793;49858.25212621886;49874;7310.159331676925;7544.811379715551;7638.121616014229;7658;7785.338246249133;8417.158284171534;10992.890071099187;11298;11458.312501249951;11484.655460336204;10093.949530252301;10191.979691404522;10254.487275636338;10289.84565231507;10537.367757934548;10142.391456512632;10210.540525676512;10216.335938163995;10327.173826094046;10446.42544660051;9946.403215807075;10069.244806639384;10270.845937311096;10522.631707890187;10531.210159237935;6689.732410703517;6690.163729533809;6787.151606049244;6965.303469652994;7692.42306826979;8270.586470676322;9673.226141908772;9877.40735555869;10433;10628.202884783826 03:10:34 INFO - PROCESS | 3414 | |3;mootools.html;1186.3652945674066;1285.0554842190988;1285.7107150891047;1328.3225554966964;1627.983720162798;6068.089786532022;6750.088738020366;6949.096617439725;6953.478489113318;7131.037309963153;7118.928810711891;7190.352868241857;7191.7842464726145;7198.892016619755;7216.963915180417;1773.2375078716148;1824.689802733532;2016.3043749906296;2056.969145462819;2057.6193404220194;2057.5267688431595;2095.968560471594;2102.915883364671;2119.9682004769943;2122.7983341582526;1972.2012584903136;1975.5357490989677;1976.2490253703572;1976.4762337980446;1998.280618977167;1775.6182420779464;1819.2268285978407;2071.9585608287825;2092.2258764257244;2096.517800905785;1991.5718120603995;2045.856790024699;2050.3746357361;2074.2117995161743;2076.0657704033247;7036.7185312587435;7113.0753002109395;7113.253108423644;7118.359347658736;7124.430045596392;4108.198901214264;4253.595908388698;4259.488861336659;4260.531341552427;4264.019275566637;2694.8681553747474;2719.7688196503323;2820.19624407043;2820.2667306500252;2820.5769134629763;854.747849384433;883.7437143228456;919.6689191890914;919.7056941778634;925.4632313258294;9464.52677366129;9534.523273836281;9563.187129094036;9582.28132890036;9586.568604412818;3750.981245093757;3958.8416463341146;4019.196160767858;4027.5166979962005;4041.535223449282;8170.468919520331;8177.877331840027;8177.918220817715;8178.182181781894;8179.263866252066;4328.978355108267;4335.393044973706;4341.240282950471;4351.390805287262;4364.170807546556;3752.512173417438;3991.6207960243732;4006.2988976929505;4011.5186177658866;4012.498437695288;3446.4141096013236;3448.1724386147143;3536.7524273300623;3541.468779683068;3565.8573657053425;1124.7637996020765;1136.3125309187988;1168.5968340922368;1176.923499972516;1186.5728337798387;596.3440215762627;738.3502517784423;751.8984937033431;757.0423414380813;776.8640487914593;4843.903121937612;4870.6103511718975;4938.629602779806;4960.131976904099;4997.675151115166;372.61434415380495;382.3385543010607;383.0978046700037;386.1485424638665;395.566854294547;3306.768526203191;3314.2377253231894;3327.068420842168;3360.5295258663805;3400.608929973035;8245.257926786619;8479.660813567512;8575.099614540384;8579.699710510102;8586.65653373858;8563.571821408905;8567.314614830922;8570.528620925785;8573.399862009599;8580.184882436159;6594.142761440982;6701.090189296125;6708.1950165979415;6714.966425167843;6717.664116794043;4707.693999889996;4715.504871988392;4745.47799742035;4893.853184404474;4959.256111583291;7716.614169291625;7823;7831.021122359705;7892.84214315722;7894.368450524059;7803.453758236869;7939.761807145795;7983.481073730189;7987.680492780224;8032.598370081356;5816.621919575214;5866.266716660418;5915.674637894957;5920.73356698941;5921.911171332347;6572.671366431564;6718.462522998051;6733.797986060426;6833.248342682202;6833.658317084027;6317.273513546001;6363.172787537776;6458.806235812933;6561;6574.27682954865;6114.296855861633;6168.9691551541955;6284.465820405317;6365.427111559982;6408.743650253938;5745.339285982165;5803.7388317524965;5842.474177324061;5862.237909071793;5886.793962211302;4378.868633940987;4423.469183697976;4476.104779044269;4504.639628829751;4611.815527378867;4347.434833471629;4415.27148020573;4426.44669416323;4494.70784399013;4537.4328208973875 03:10:34 INFO - PROCESS | 3414 | |4;prototype.html;298.30494946774013;300.6257209773832;305.47305897327107;307.97536197104233;309.25006858368465;4813.844677277454;4836.177849765535;4842.709437433757;4859.829905953292;4867.906800075966;4789.544993225638;4795.865839701334;4802.495737947517;4803.63972702047;4811.398575178103;3571.910702232439;3639.3813051781262;3694.131879008431;3740.382836831933;3757.718171137162;3760.492333534965;3773.811309434531;3775.3015692096915;3790.2987947229713;3797.9430308545393;3724.608916063815;3731.925361492782;3744;3754.6620804127624;3757.9248415031684;3618.8009659468717;3686.262747450494;3711.5917249102577;3750.8499660013567;3770.6606405423645;3304.322613864176;3324.9501257481156;3333.21669407689;3339.532465454838;3351.8491667875005;4680.251159814447;4686.297055441711;4697.895994441304;4699.694519856198;4705.247160454311;4007.2586571484367;4223.450951376332;4297.505786834523;4307.82768689252;4310.82756689732;4979.278004689299;4992.975035124838;5005.874853128665;5013.573846223076;5014.172661510846;3575.106223444139;3578.624244454347;3607.693346065588;3612.151144481045;3616.529851119364;5058;5304.602154838364;5336.332958380202;5336.43967383423;5361.758720857531;3719.3491139050557;3803.2963901678277;3824.4263360495593;3831.2337532493057;3853.653171214548;3900.01099439288;3900.941485877714;3901.122247494291;3905.7070719696135;3908.2769687607883;4375.212461756914;4380.16776812411;4385.6710746694125;4400.44994375703;4407.493138289138;4928.778204980713;4985.376827896513;4989.750512474362;5020.368380276424;5172.637915345889;1276.527684756646;1299.27240745183;1301.7786976214065;1302.3162839509143;1307.901907356952;840.0087896282323;865.2731705367521;901.4005686218591;920.3419555018194;925.713258570574;4181.686373521998;4331.350297455344;4445.177642136216;4457.3091170868565;4467.798949047301;5151.639385243072;5184.8963020739375;5193.883669798166;5206.661566998133;5234.874501982092;4293.849715259951;4440.600345968814;4447.822087116544;4447.888802779957;4467.865964021084;2630.0005997720746;2645.470905818844;2661.467706458716;2668.479646468959;2675.17069708391;4635.536446355405;4662.930056049162;4669.855885308053;4688.765561721969;4689.812407503729;4872.4640289568115;5154.7164905929785;5155.329807125125;5162.586993040548;5174.24973378858;4592.219322715213;4616.192166370872;4632.374629424984;4636.863968327714;4697.882552936204;5007.24891266313;5017.498250174954;5026.547610715053;5045.470225626256;5046.924296135488;4672.415948006499;4937.950620493749;4956.405231372259;4994.1759609663995;4995.975020124876;4596.655250856266;4618.699784513996;4632.4481298765295;4634.675572709878;4651.093051848726;3682.8710995115043;3689.391250443754;3690.870819521304;3719.832607532722;3733.663970242691;5062.417821950523;5065.822696205615;5072.365954255718;5083.466236045162;5090.440051594248;4636.489986101458;4816.325714400057;4856.78144483492;4858.82994095205;4873.634477414279;4847.394075740533;4864.975675121602;4873.317735517101;4877.829275975466;4878.707277563216;4720.976395118139;4736.810527578996;4764.523547645208;4772.832950846704;4784.40194975628;4670.929936050894;4870.561649451424;4881.29221262922;4894.437139728977;4923.679960802537;4771.451283102488;4775.498572649822;4781.545753153445;4800.919793046676;4812.783424745965 03:10:34 INFO - PROCESS | 3414 | |5;yui.html;619.3125630550088;626.2359920896505;630.2374127305957;637.9202599675041;700.8773464643687;13323.800142997863;13505.662358441032;13542.45830166792;13666.931665341684;14004.789928151073;12233;12456;12463;12472.126951113425;12476.50093996239;626.7900253415112;756.9016027916363;771.533222400448;772.4476998945753;772.8338407242442;640.6508452893161;749.5015814483362;764.5412752348602;769.499825113675;779.3726050529322;814.2752949874616;815.2011029191395;815.2581151152452;816.1063635319316;816.302061737215;651.1957732200729;809.8258874342015;810.4448452809844;810.793247721833;810.8459392715365;483.23889873449457;569.4191924237297;582.4670426559693;583.3845293215655;586.4106572894214;13208.801867971988;13239.139455935334;13240.404181811842;13241.668958276025;13255.46978120874;12773.87040175163;12795.48818047277;13188.802167967488;13254.40355184019;13333.399997000159;11910.940445297805;11977.341246231541;11999.400029998553;12045.92828828652;12047;3976.224636195943;4058.61443162902;4067.959320406788;4152.5432202457705;4217.114405974749;63134;64491;65308.346916531176;65662.3433765661;66314.33685663178;9717.611295548098;9798.46108464027;9976.80046399068;10000.199984001263;10116.190704743603;18018;18019.909900450413;18021.549461263312;18023.819761802213;18076;6287.962486189819;6379.553431259767;6412.743490260431;6466.5473416861305;6485.254195767453;3520.049278702843;3584.9641503585153;3590.4075827488696;3606.062423769786;3607.639236076424;2491.7632824881607;2567.8587677677906;2573.4081161332997;2575.987120064388;2578.716341202466;453.1322517379248;465.6368032934317;470.9905801883943;476.5806090640214;492.2517772985114;496.4365445219702;510.67316917173036;511.86179731472293;513.8432778002744;524.8845254044104;6999.370056694922;7128.094016155291;7283.927160728324;7457;7740.574268415178;490.18139706689914;492.91374009548184;500.5445045009024;504.31665093797375;521.7730287324949;3537.593176784703;3661.7436779425716;3678.356287649704;3798.677112445473;3914.158455931988;53886.730566346916;68492.31507684958;69608.3039169612;71148.2885171152;73362;59257.70371148117;59592;62300.37699622946;62931.685341573;64397.356026439134;46708.53291467178;55796.72101639466;55878.44121558814;56733.71633141808;56984;8296.700570578021;8594.226519613265;8664.480131191896;8692.478451292942;8924.776880577778;31527.684723153394;34902;36132.4580131293;36751.26497469982;38200.61799381971;46038.309425359315;49964.500354997435;50536;51196.232056519926;53368.73315633397;11264.493097810782;11294.49174787153;11383.886161138282;11391.430428478709;11654.88345116538;12195.451204695633;12359.32023738667;12567.685807854878;13239.376255238818;13490.392932317873;10424;10773.89226107729;10919.181061420584;10948.890511094787;11607.071434285406;11182;11184.496697648463;11702.122340824302;11816.350100744541;11855.288682679067;11358.432078396212;11491.885081149416;11558.711032224262;12231.082668799698;12253.754924901274;10156.746081348025;10337.638182663572;10407.843882341922;10574.682759517227;10648.787024259316;10268.743281418025;10407.739806504898;10657.413842238751;10679.51942162589;10706.464676765974 03:10:34 INFO - PROCESS | 3414 | __end_tp_report 03:10:34 INFO - PROCESS | 3414 | __start_cc_report 03:10:34 INFO - PROCESS | 3414 | _x_x_mozilla_cycle_collect,2466 03:10:34 INFO - PROCESS | 3414 | __end_cc_report 03:10:34 INFO - PROCESS | 3414 | __startTimestamp1481109034204__endTimestamp 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | ------- Summary: start ------- 03:10:34 INFO - PROCESS | 3414 | Number of tests: 6 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#0] dojo.html Cycles:165 Average:4545.71 Median:4661.51 stddev:470.10 (10.1%) stddev-sans-first:445.46 03:10:34 INFO - PROCESS | 3414 | Values: 2577.4 2609.5 2618.0 2618.8 2636.1 4450.3 4543.5 4629.1 4643.0 4646.8 4556.7 4563.5 4572.5 4573.4 4588.2 4169.8 4192.1 4199.6 4220.4 4226.2 4221.8 4222.5 4223.4 4231.9 4237.9 4217.4 4235.0 4268.1 4270.3 4318.8 4279.0 4282.7 4284.9 4290.4 4316.1 4104.2 4111.4 4138.4 4191.1 4258.8 4603.6 4661.9 4668.2 4674.6 4676.6 4983.9 4987.8 4990.1 5017.5 5054.3 4799.9 4826.3 5034.6 5040.7 5089.1 4607.8 4619.2 4650.3 4657.5 4724.1 5093.7 5099.1 5107.3 5108.6 5144.3 4855.4 4857.2 4862.1 4886.6 4903.0 4681.9 4736.0 4737.2 4867.9 4898.1 4871.4 4884.1 4904.6 4920.2 4925.3 4835.9 4875.1 4881.9 4889.6 4934.8 4080.2 4111.3 4141.9 4249.4 4302.1 3674.4 3677.9 3684.7 3702.6 3739.4 4203.7 4205.9 4211.8 4214.4 4249.3 4803.6 4915.3 4915.8 4921.9 4961.5 4154.7 4168.9 4190.8 4240.3 4248.9 4517.0 4520.0 4523.9 4533.1 4553.3 4585.5 4588.7 4615.9 4628.0 4661.5 4790.1 4861.8 4862.9 4924.1 4926.6 4467.2 4501.1 4512.6 4513.8 4515.8 4774.1 4775.0 4775.7 4777.4 4781.1 4835.9 4838.4 4840.1 4840.6 4841.6 4682.1 4716.9 4719.5 4722.2 4723.8 4786.6 4848.0 4861.2 4896.4 4932.9 4763.0 4771.2 4774.0 4793.5 4819.3 4872.9 4907.5 4911.1 4916.3 4934.3 4595.9 4638.1 4642.8 4699.0 4792.5 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#1] ext.html Cycles:180 Average:45452.73 Median:36357.64 stddev:79942.27 (219.9%) stddev-sans-first:80095.42 03:10:34 INFO - PROCESS | 3414 | Values: 544.5 563.4 591.1 594.0 595.3 36065.3 37193.0 37480.3 40833.4 40900.6 39194.6 39622.4 39672.8 39781.4 39911.2 7273.5 7300.5 7430.9 7431.0 7433.6 9526.9 9774.3 9779.5 10063.1 10088.4 9780.6 9857.8 9860.9 9862.7 9865.5 9265.4 9295.9 9320.9 9325.8 9341.3 9788.9 9817.9 9845.6 9858.1 9859.6 37450.8 37486.0 37531.2 37742.6 37779.4 2806.6 2868.7 3147.8 3281.1 3356.7 27789.7 28129.0 28202.6 28254.0 28919.4 3306.9 3438.1 3457.9 3467.3 3521.0 254474.0 256741.0 257648.0 257720.7 258431.0 50123.2 50531.7 50535.0 50550.0 50554.5 52528.7 52539.5 52599.0 52632.2 52660.5 11252.1 11757.9 11825.1 11831.9 11843.3 7803.6 8007.4 8013.0 8192.9 8624.1 13405.0 14744.7 14962.2 15034.2 15651.8 5683.7 5752.7 5754.5 5856.7 5869.6 680.0 753.3 829.3 835.5 942.9 26212.0 28784.9 29251.7 30786.5 31185.7 896.3 921.5 926.3 929.4 1016.5 13273.4 14343.4 14381.9 14468.1 14625.7 339890.0 345857.0 346382.0 347840.0 348069.0 47288.8 47428.0 47657.8 47800.8 47812.3 1012.9 1087.9 1101.6 1146.9 1185.8 24998.5 27904.6 28887.6 29357.3 29359.9 35956.0 36341.3 36374.0 36397.5 36453.5 302507.0 304038.0 305508.0 306064.0 306785.0 36780.8 37483.8 38073.6 39886.2 40219.2 39427.6 40209.4 40211.8 40306.4 40321.4 31117.0 31543.0 31943.7 32149.4 32265.7 29586.9 30837.4 31435.0 32235.2 34987.8 32643.2 32739.2 33115.8 33290.0 33423.7 28646.0 30683.8 30934.4 31094.7 31192.8 23575.3 23664.5 23895.3 24124.0 24246.8 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#2] jquery.html Cycles:180 Average:22231.16 Median:26601.45 stddev:58050.69 (218.2%) stddev-sans-first:58190.30 03:10:34 INFO - PROCESS | 3414 | Values: 351.2 368.5 378.3 378.4 393.6 12440.2 12518.9 13293.5 16255.3 16931.3 14509.0 15275.2 16312.3 16427.5 16435.3 4810.4 5043.6 5280.4 5317.2 5400.4 3421.0 5283.6 5311.2 5317.1 5325.7 3500.0 3820.0 3869.3 5702.2 5778.3 5798.4 5812.2 5815.0 5827.3 5828.2 4967.4 5083.8 5109.8 5120.7 5129.7 11807.4 12122.9 12252.6 12270.4 12290.1 1813.4 1976.9 2123.8 2303.7 2402.1 8375.7 8733.7 9186.7 9230.0 9321.8 1642.5 1721.6 1738.3 1772.5 1779.7 61010.0 65349.7 65353.3 65370.0 66408.0 9496.0 9562.3 9651.0 9892.5 9976.3 13076.0 13104.9 13113.5 13123.3 13211.8 6068.7 6111.4 6281.2 6329.7 6359.7 5544.5 5631.5 5681.1 5733.5 5864.3 3988.1 4102.7 4136.0 4152.5 4261.1 1779.2 1795.7 1810.9 1821.3 1866.5 742.4 752.2 777.7 869.0 880.2 15412.6 16073.7 16141.5 16180.2 16802.6 782.6 803.3 816.9 832.7 897.3 8676.3 9080.5 9162.7 9313.9 9452.0 347696.0 348431.0 348798.8 354437.0 356744.0 55872.7 59698.0 72824.0 75665.0 77982.0 857.9 869.9 871.2 873.4 877.9 14605.0 15220.0 15766.9 15803.5 16134.4 34942.8 36122.6 36673.8 36807.4 37355.3 46262.8 48392.5 49669.5 49858.3 49874.0 7310.2 7544.8 7638.1 7658.0 7785.3 8417.2 10992.9 11298.0 11458.3 11484.7 10093.9 10192.0 10254.5 10289.8 10537.4 10142.4 10210.5 10216.3 10327.2 10446.4 9946.4 10069.2 10270.8 10522.6 10531.2 6689.7 6690.2 6787.2 6965.3 7692.4 8270.6 9673.2 9877.4 10433.0 10628.2 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#3] mootools.html Cycles:180 Average:4689.02 Median:4916.24 stddev:2565.86 (52.2%) stddev-sans-first:2559.56 03:10:34 INFO - PROCESS | 3414 | Values: 1186.4 1285.1 1285.7 1328.3 1628.0 6068.1 6750.1 6949.1 6953.5 7131.0 7118.9 7190.4 7191.8 7198.9 7217.0 1773.2 1824.7 2016.3 2057.0 2057.6 2057.5 2096.0 2102.9 2120.0 2122.8 1972.2 1975.5 1976.2 1976.5 1998.3 1775.6 1819.2 2072.0 2092.2 2096.5 1991.6 2045.9 2050.4 2074.2 2076.1 7036.7 7113.1 7113.3 7118.4 7124.4 4108.2 4253.6 4259.5 4260.5 4264.0 2694.9 2719.8 2820.2 2820.3 2820.6 854.7 883.7 919.7 919.7 925.5 9464.5 9534.5 9563.2 9582.3 9586.6 3751.0 3958.8 4019.2 4027.5 4041.5 8170.5 8177.9 8177.9 8178.2 8179.3 4329.0 4335.4 4341.2 4351.4 4364.2 3752.5 3991.6 4006.3 4011.5 4012.5 3446.4 3448.2 3536.8 3541.5 3565.9 1124.8 1136.3 1168.6 1176.9 1186.6 596.3 738.4 751.9 757.0 776.9 4843.9 4870.6 4938.6 4960.1 4997.7 372.6 382.3 383.1 386.1 395.6 3306.8 3314.2 3327.1 3360.5 3400.6 8245.3 8479.7 8575.1 8579.7 8586.7 8563.6 8567.3 8570.5 8573.4 8580.2 6594.1 6701.1 6708.2 6715.0 6717.7 4707.7 4715.5 4745.5 4893.9 4959.3 7716.6 7823.0 7831.0 7892.8 7894.4 7803.5 7939.8 7983.5 7987.7 8032.6 5816.6 5866.3 5915.7 5920.7 5921.9 6572.7 6718.5 6733.8 6833.2 6833.7 6317.3 6363.2 6458.8 6561.0 6574.3 6114.3 6169.0 6284.5 6365.4 6408.7 5745.3 5803.7 5842.5 5862.2 5886.8 4378.9 4423.5 4476.1 4504.6 4611.8 4347.4 4415.3 4426.4 4494.7 4537.4 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#4] prototype.html Cycles:180 Average:4132.46 Median:4657.01 stddev:1172.91 (25.2%) stddev-sans-first:1140.35 03:10:34 INFO - PROCESS | 3414 | Values: 298.3 300.6 305.5 308.0 309.3 4813.8 4836.2 4842.7 4859.8 4867.9 4789.5 4795.9 4802.5 4803.6 4811.4 3571.9 3639.4 3694.1 3740.4 3757.7 3760.5 3773.8 3775.3 3790.3 3797.9 3724.6 3731.9 3744.0 3754.7 3757.9 3618.8 3686.3 3711.6 3750.8 3770.7 3304.3 3325.0 3333.2 3339.5 3351.8 4680.3 4686.3 4697.9 4699.7 4705.2 4007.3 4223.5 4297.5 4307.8 4310.8 4979.3 4993.0 5005.9 5013.6 5014.2 3575.1 3578.6 3607.7 3612.2 3616.5 5058.0 5304.6 5336.3 5336.4 5361.8 3719.3 3803.3 3824.4 3831.2 3853.7 3900.0 3900.9 3901.1 3905.7 3908.3 4375.2 4380.2 4385.7 4400.4 4407.5 4928.8 4985.4 4989.8 5020.4 5172.6 1276.5 1299.3 1301.8 1302.3 1307.9 840.0 865.3 901.4 920.3 925.7 4181.7 4331.4 4445.2 4457.3 4467.8 5151.6 5184.9 5193.9 5206.7 5234.9 4293.8 4440.6 4447.8 4447.9 4467.9 2630.0 2645.5 2661.5 2668.5 2675.2 4635.5 4662.9 4669.9 4688.8 4689.8 4872.5 5154.7 5155.3 5162.6 5174.2 4592.2 4616.2 4632.4 4636.9 4697.9 5007.2 5017.5 5026.5 5045.5 5046.9 4672.4 4938.0 4956.4 4994.2 4996.0 4596.7 4618.7 4632.4 4634.7 4651.1 3682.9 3689.4 3690.9 3719.8 3733.7 5062.4 5065.8 5072.4 5083.5 5090.4 4636.5 4816.3 4856.8 4858.8 4873.6 4847.4 4865.0 4873.3 4877.8 4878.7 4721.0 4736.8 4764.5 4772.8 4784.4 4670.9 4870.6 4881.3 4894.4 4923.7 4771.5 4775.5 4781.5 4800.9 4812.8 03:10:34 INFO - PROCESS | 3414 | 03:10:34 INFO - PROCESS | 3414 | [#5] yui.html Cycles:180 Average:15218.99 Median:4184.83 stddev:19364.41 (462.7%) stddev-sans-first:19387.70 03:10:34 INFO - PROCESS | 3414 | Values: 619.3 626.2 630.2 637.9 700.9 13323.8 13505.7 13542.5 13666.9 14004.8 12233.0 12456.0 12463.0 12472.1 12476.5 626.8 756.9 771.5 772.4 772.8 640.7 749.5 764.5 769.5 779.4 814.3 815.2 815.3 816.1 816.3 651.2 809.8 810.4 810.8 810.8 483.2 569.4 582.5 583.4 586.4 13208.8 13239.1 13240.4 13241.7 13255.5 12773.9 12795.5 13188.8 13254.4 13333.4 11910.9 11977.3 11999.4 12045.9 12047.0 3976.2 4058.6 4068.0 4152.5 4217.1 63134.0 64491.0 65308.3 65662.3 66314.3 9717.6 9798.5 9976.8 10000.2 10116.2 18018.0 18019.9 18021.5 18023.8 18076.0 6288.0 6379.6 6412.7 6466.5 6485.3 3520.0 3585.0 3590.4 3606.1 3607.6 2491.8 2567.9 2573.4 2576.0 2578.7 453.1 465.6 471.0 476.6 492.3 496.4 510.7 511.9 513.8 524.9 6999.4 7128.1 7283.9 7457.0 7740.6 490.2 492.9 500.5 504.3 521.8 3537.6 3661.7 3678.4 3798.7 3914.2 53886.7 68492.3 69608.3 71148.3 73362.0 59257.7 59592.0 62300.4 62931.7 64397.4 46708.5 55796.7 55878.4 56733.7 56984.0 8296.7 8594.2 8664.5 8692.5 8924.8 31527.7 34902.0 36132.5 36751.3 38200.6 46038.3 49964.5 50536.0 51196.2 53368.7 11264.5 11294.5 11383.9 11391.4 11654.9 12195.5 12359.3 12567.7 13239.4 13490.4 10424.0 10773.9 10919.2 10948.9 11607.1 11182.0 11184.5 11702.1 11816.4 11855.3 11358.4 11491.9 11558.7 12231.1 12253.8 10156.7 10337.6 10407.8 10574.7 10648.8 10268.7 10407.7 10657.4 10679.5 10706.5 03:10:34 INFO - PROCESS | 3414 | -------- Summary: end -------- 03:10:34 INFO - PROCESS | 3414 | 03:10:35 INFO - TEST-INFO | 3414: exit 0 03:10:35 INFO - TEST-OK | dromaeo_css | took 1125390ms 03:10:35 INFO - TEST-START | kraken 03:10:35 INFO - operating with platform_type : linux_ 03:10:35 INFO - Initialising browser for kraken test... 03:10:35 INFO - TEST-INFO | started process 3756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAiHlBb/profile http://localhost:43365/getInfo.html) 03:10:39 INFO - PROCESS | 3756 | __metrics Screen width/height:1600/1200 03:10:39 INFO - PROCESS | 3756 | colorDepth:24 03:10:39 INFO - PROCESS | 3756 | Browser inner width/height: 1024/697 03:10:39 INFO - PROCESS | 3756 | __metrics 03:10:40 INFO - PROCESS | 3756 | 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" 03:10:40 INFO - PROCESS | 3756 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:41 INFO - PROCESS | 3756 | console.error: PushService: 03:10:41 INFO - PROCESS | 3756 | stateChangeProcessEnqueue: Error transitioning state 03:10:41 INFO - PROCESS | 3756 | UnknownError 03:10:41 INFO - TEST-INFO | 3756: exit 0 03:10:41 INFO - Browser initialized. 03:10:41 INFO - Running cycle 1/1 for kraken test... 03:10:41 INFO - TEST-INFO | started process 3837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAiHlBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:54 INFO - PROCESS | 3837 | RSS: Main: 173629440 03:10:54 INFO - PROCESS | 3837 | 03:10:56 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43365/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:57 INFO - PROCESS | 3837 | RSS: Main: 239255552 03:10:57 INFO - PROCESS | 3837 | 03:11:00 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43365/tests/kraken/driver.html?testName=audio-dft) 03:11:01 INFO - PROCESS | 3837 | RSS: Main: 218079232 03:11:01 INFO - PROCESS | 3837 | 03:11:04 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43365/tests/kraken/driver.html?testName=audio-fft) 03:11:04 INFO - PROCESS | 3837 | RSS: Main: 300507136 03:11:04 INFO - PROCESS | 3837 | 03:11:07 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43365/tests/kraken/driver.html?testName=audio-oscillator) 03:11:07 INFO - PROCESS | 3837 | RSS: Main: 211656704 03:11:07 INFO - PROCESS | 3837 | 03:11:09 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:10 INFO - PROCESS | 3837 | RSS: Main: 214712320 03:11:10 INFO - PROCESS | 3837 | 03:11:13 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43365/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:14 INFO - PROCESS | 3837 | RSS: Main: 254476288 03:11:14 INFO - PROCESS | 3837 | 03:11:17 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43365/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:18 INFO - PROCESS | 3837 | RSS: Main: 248266752 03:11:18 INFO - PROCESS | 3837 | 03:11:21 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43365/tests/kraken/driver.html?testName=json-parse-financial) 03:11:21 INFO - PROCESS | 3837 | RSS: Main: 250138624 03:11:21 INFO - PROCESS | 3837 | 03:11:23 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:24 INFO - PROCESS | 3837 | RSS: Main: 213155840 03:11:24 INFO - PROCESS | 3837 | 03:11:26 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:26 INFO - PROCESS | 3837 | RSS: Main: 221458432 03:11:26 INFO - PROCESS | 3837 | 03:11:29 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:29 INFO - PROCESS | 3837 | RSS: Main: 229646336 03:11:29 INFO - PROCESS | 3837 | 03:11:32 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:33 INFO - PROCESS | 3837 | RSS: Main: 238215168 03:11:33 INFO - PROCESS | 3837 | 03:11:36 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:36 INFO - PROCESS | 3837 | RSS: Main: 235741184 03:11:36 INFO - PROCESS | 3837 | 03:11:38 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:43365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43365/tests/kraken/driver.html?testName=ai-astar) 03:11:39 INFO - PROCESS | 3837 | RSS: Main: 286334976 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | __start_tp_report 03:11:39 INFO - PROCESS | 3837 | _x_x_mozilla_page_load 03:11:39 INFO - PROCESS | 3837 | _x_x_mozilla_page_load_details 03:11:39 INFO - PROCESS | 3837 | |i|pagename|runs| 03:11:39 INFO - PROCESS | 3837 | |0;ai-astar;113;117;116;116;117;114;115;116;114;116 03:11:39 INFO - PROCESS | 3837 | |1;audio-beat-detection;154;135;127;166;133;132;127;134;157;129 03:11:39 INFO - PROCESS | 3837 | |2;audio-dft;163;164;161;162;162;162;163;161;160;162 03:11:39 INFO - PROCESS | 3837 | |3;audio-fft;75;76;76;107;77;77;77;86;88;77 03:11:39 INFO - PROCESS | 3837 | |4;audio-oscillator;83;84;120;84;83;84;98;85;84;111 03:11:39 INFO - PROCESS | 3837 | |5;imaging-gaussian-blur;117;117;116;118;117;117;118;118;117;116 03:11:39 INFO - PROCESS | 3837 | |6;imaging-darkroom;146;146;147;146;146;146;146;147;147;147 03:11:39 INFO - PROCESS | 3837 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 03:11:39 INFO - PROCESS | 3837 | |8;json-parse-financial;66;77;63;63;65;65;64;65;65;64 03:11:39 INFO - PROCESS | 3837 | |9;json-stringify-tinderbox;66;66;66;67;67;66;79;66;65;66 03:11:39 INFO - PROCESS | 3837 | |10;stanford-crypto-aes;85;85;85;86;92;91;86;86;86;85 03:11:39 INFO - PROCESS | 3837 | |11;stanford-crypto-ccm;150;145;139;152;147;135;141;145;184;138 03:11:39 INFO - PROCESS | 3837 | |12;stanford-crypto-pbkdf2;177;181;183;179;178;177;179;175;177;180 03:11:39 INFO - PROCESS | 3837 | |13;stanford-crypto-sha256-iterative;69;71;71;69;68;69;72;68;67;68 03:11:39 INFO - PROCESS | 3837 | __end_tp_report 03:11:39 INFO - PROCESS | 3837 | __start_cc_report 03:11:39 INFO - PROCESS | 3837 | _x_x_mozilla_cycle_collect,1927 03:11:39 INFO - PROCESS | 3837 | __end_cc_report 03:11:39 INFO - PROCESS | 3837 | __startTimestamp1481109099011__endTimestamp 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | ------- Summary: start ------- 03:11:39 INFO - PROCESS | 3837 | Number of tests: 14 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.35 (1.2%) stddev-sans-first:1.12 03:11:39 INFO - PROCESS | 3837 | Values: 113.0 117.0 116.0 116.0 117.0 114.0 115.0 116.0 114.0 116.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:134.50 stddev:14.10 (10.5%) stddev-sans-first:13.94 03:11:39 INFO - PROCESS | 3837 | Values: 154.0 135.0 127.0 166.0 133.0 132.0 127.0 134.0 157.0 129.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 03:11:39 INFO - PROCESS | 3837 | Values: 163.0 164.0 161.0 162.0 162.0 162.0 163.0 161.0 160.0 162.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:9.98 (13.0%) stddev-sans-first:10.30 03:11:39 INFO - PROCESS | 3837 | Values: 75.0 76.0 76.0 107.0 77.0 77.0 77.0 86.0 88.0 77.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:13.53 (16.1%) stddev-sans-first:13.98 03:11:39 INFO - PROCESS | 3837 | Values: 83.0 84.0 120.0 84.0 83.0 84.0 98.0 85.0 84.0 111.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:11:39 INFO - PROCESS | 3837 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 118.0 118.0 117.0 116.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:11:39 INFO - PROCESS | 3837 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:11:39 INFO - PROCESS | 3837 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:4.08 (6.3%) stddev-sans-first:4.33 03:11:39 INFO - PROCESS | 3837 | Values: 66.0 77.0 63.0 63.0 65.0 65.0 64.0 65.0 65.0 64.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:66.00 stddev:4.12 (6.2%) stddev-sans-first:4.33 03:11:39 INFO - PROCESS | 3837 | Values: 66.0 66.0 66.0 67.0 67.0 66.0 79.0 66.0 65.0 66.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.58 (3.0%) stddev-sans-first:2.67 03:11:39 INFO - PROCESS | 3837 | Values: 85.0 85.0 85.0 86.0 92.0 91.0 86.0 86.0 86.0 85.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:146.00 stddev:13.87 (9.5%) stddev-sans-first:14.69 03:11:39 INFO - PROCESS | 3837 | Values: 150.0 145.0 139.0 152.0 147.0 135.0 141.0 145.0 184.0 138.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.00 stddev:2.32 (1.3%) stddev-sans-first:2.39 03:11:39 INFO - PROCESS | 3837 | Values: 177.0 181.0 183.0 179.0 178.0 177.0 179.0 175.0 177.0 180.0 03:11:39 INFO - PROCESS | 3837 | 03:11:39 INFO - PROCESS | 3837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.72 03:11:39 INFO - PROCESS | 3837 | Values: 69.0 71.0 71.0 69.0 68.0 69.0 72.0 68.0 67.0 68.0 03:11:39 INFO - PROCESS | 3837 | -------- Summary: end -------- 03:11:39 INFO - PROCESS | 3837 | 03:11:40 INFO - TEST-INFO | 3837: exit 0 03:11:40 INFO - TEST-OK | kraken | took 65109ms 03:11:40 INFO - SUITE-END | took 1190s 03:11:40 INFO - Completed test suite (00:19:50) 03:11:40 INFO - javascript benchmark 03:11:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.368544706547, 2609.5433299172664, 2618.0, 2618.8297760645564, 2636.1300770745643, 4450.26570615848, 4543.500214976359, 4629.051044535866, 4643.0481751240995, 4646.814127434903, 4556.726596404218, 4563.498015218323, 4572.519885412034, 4573.428321459817, 4588.220002599558, 4169.833206671737, 4192.140611174702, 4199.580041995807, 4220.388043733657, 4226.1547690461875, 4221.810018549173, 4222.535521092677, 4223.366495025755, 4231.894202644943, 4237.87286381409, 4217.388478670591, 4235.025944032875, 4268.061026574149, 4270.338097594862, 4318.82724691012, 4279.037216626265, 4282.700210985232, 4284.871453856389, 4290.442242508485, 4316.07204451043, 4104.220198162339, 4111.383292506118, 4138.358554424069, 4191.098913733532, 4258.829646814123, 4603.562661547147, 4661.86014419568, 4668.206404911173, 4674.649401294916, 4676.625869930397, 4983.875403114915, 4987.750612469362, 4990.051890140898, 5017.523335283142, 5054.3176671149295, 4799.904001919942, 4826.276058591205, 5034.588587007806, 5040.697558146523, 5089.05852417304, 4607.769611519444, 4619.214733495314, 4650.279206722963, 4657.4876763555985, 4724.102420540086, 5093.694378337312, 5099.082165210223, 5107.310513080686, 5108.642395032312, 5144.331236939249, 4855.417349918032, 4857.1742803723455, 4862.100511405401, 4886.633502487328, 4902.975485122623, 4681.882952926204, 4736.029114031615, 4737.170995075848, 4867.9269810952865, 4898.069366820293, 4871.415430148334, 4884.12085824555, 4904.55858972687, 4920.163572192736, 4925.261210818334, 4835.927461088087, 4875.122477953932, 4881.926771098437, 4889.584385327287, 4934.802607895644, 4080.235707270622, 4111.321631930698, 4141.937870931938, 4249.383839343278, 4302.053548219386, 3674.375356189454, 3677.9080522987138, 3684.6683798458266, 3702.648248416396, 3739.383001804726, 4203.6637069034405, 4205.894852628709, 4211.810468528924, 4214.388913607571, 4249.256380133526, 4803.615710743132, 4915.287283343967, 4915.827946021944, 4921.8523444296725, 4961.503849615082, 4154.709170358046, 4168.936921085165, 4190.769507677046, 4240.342746874239, 4248.893777655583, 4516.954830451719, 4519.954800452019, 4523.932141017887, 4533.070720502289, 4553.2942393929, 4585.4726706427855, 4588.7246765194195, 4615.907681846412, 4627.958709290383, 4661.510541393241, 4790.113828941657, 4861.756912154449, 4862.902741945212, 4924.064427758714, 4926.556609905126, 4467.2405691033255, 4501.054778496552, 4512.593866552026, 4513.75174365413, 4515.774211289357, 4774.069056533943, 4775.044991001744, 4775.737334446639, 4777.355057067251, 4781.067691800065, 4835.927461088017, 4838.371011768448, 4840.128776820206, 4840.6127509799835, 4841.612670986242, 4682.0869930364615, 4716.858494245178, 4719.457262414729, 4722.173619616622, 4723.763811809327, 4786.635808794616, 4847.95152048475, 4861.1979023460735, 4896.436909755424, 4932.8520144395725, 4763.0, 4771.1650461168465, 4774.045190961752, 4793.472718000948, 4819.3012013258585, 4872.9269060964825, 4907.484714104968, 4911.091448081973, 4916.262560615936, 4934.333864928189, 4595.862124136282, 4638.1187574360765, 4642.814287428465, 4698.9530104698515, 4792.496787837227], "value": 4516.417119921132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.4609836262101, 563.3718403979564, 591.1015256809652, 594.031728282899, 595.2916029924389, 36065.278694426095, 37193.0, 37480.250394992116, 40833.38749918746, 40900.590994090126, 39194.608053919525, 39622.40566391499, 39672.80163599178, 39781.40327895084, 39911.201775964466, 7273.490855640107, 7300.4524660650395, 7430.925690743077, 7430.962845185766, 7433.553986760785, 9526.904730952705, 9774.31579789415, 9779.511024448784, 10063.144632706191, 10088.445135517544, 9780.559874805615, 9857.753556161082, 9860.852087218698, 9862.704118876445, 9865.457399843006, 9265.444073355553, 9295.860562091573, 9320.8601870972, 9325.813483730355, 9341.346105772598, 9788.853167202426, 9817.852732209023, 9845.55694993727, 9858.063483969012, 9859.570362297498, 37450.8127459361, 37486.0, 37531.24937501262, 37742.622573774184, 37779.4333085004, 2806.593044008607, 2868.727470890262, 3147.7953932994283, 3281.0976981330086, 3356.7482438817187, 27789.722102778916, 28129.0, 28202.576961345596, 28254.0, 28919.409432481207, 3306.9173270668184, 3438.0717206354393, 3457.9308413831836, 3467.254540273828, 3521.031716278044, 254474.0, 256740.99999999814, 257648.0, 257720.7113964437, 258431.0, 50123.24815127776, 50531.74734126379, 50535.0, 50550.0, 50554.49445505571, 52528.73735631297, 52539.47460525346, 52599.0, 52632.21051684228, 52660.46790641887, 11252.099832013419, 11757.941210293893, 11825.053995680324, 11831.940840295743, 11843.34861582604, 7803.609819509002, 8007.399445041645, 8012.958315418959, 8192.918070819334, 8624.137586241452, 13405.0, 14744.705105897821, 14962.17708026069, 15034.17312047848, 15651.765223521656, 5683.744231509592, 5752.741126649311, 5754.482096611325, 5856.707164641751, 5869.559783016291, 680.034351221267, 753.3069575990103, 829.2619568583965, 835.5488036460365, 942.9339946203837, 26212.0, 28784.856075719486, 29251.7074829249, 30786.53820192699, 31185.688143118277, 896.3411892259185, 921.4517362169498, 926.3376685669779, 929.3819609959437, 1016.506994107857, 13273.402696878471, 14343.354549045318, 14381.92809035948, 14468.131912085308, 14625.707485850224, 339890.0, 345857.0, 346382.0, 347840.0, 348069.0, 47288.763556182, 47428.0, 47657.80448541667, 47800.7609961948, 47812.28281575779, 1012.9290949633455, 1087.853139826129, 1101.581399068349, 1146.8681101673249, 1185.8161984892183, 24998.50002999966, 27904.58143127814, 28887.56668650014, 29357.26606834846, 29359.853200733858, 35956.0, 36341.27317453689, 36374.0, 36397.45403818892, 36453.45319820258, 302507.0, 304038.0, 305508.0, 306064.0, 306785.0, 36780.81609591935, 37483.81258093692, 38073.61926380811, 39886.2022759549, 40219.19561608693, 39427.60572394239, 40209.39685904655, 40211.79894100628, 40306.395404069546, 40321.39517907175, 31117.0, 31543.0, 31943.68056319407, 32149.35701286008, 32265.677343226267, 29586.852065739535, 30837.383252334377, 31435.0, 32235.194120146247, 34987.82506087453, 32643.18392040218, 32739.181520462178, 33115.83442082774, 33290.0, 33423.665763342055, 28646.0, 30683.772649093786, 30934.381312374077, 31094.689053110083, 31192.844035779675, 23575.292741217792, 23664.52670946537, 23895.283141505784, 24124.0, 24246.75753242445], "value": 17098.90523996004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.24657609427794, 368.54852805313476, 378.31336124933244, 378.42857285498894, 393.63981956509775, 12440.191387559813, 12518.874811251884, 13293.534726284583, 16255.268512916917, 16931.322747090133, 14509.0, 15275.159866207354, 16312.347506099743, 16427.507174784747, 16435.2604132814, 4810.374651295327, 5043.5965122790085, 5280.392754833186, 5317.202419637066, 5400.378956420003, 3420.9828950855335, 5283.63014588979, 5311.203319502086, 5317.069512835258, 5325.680459172462, 3500.0, 3820.0449887528116, 3869.2648396804516, 5702.173184888189, 5778.335491418498, 5798.449147330997, 5812.157237200582, 5815.0, 5827.271591051119, 5828.2131912191735, 4967.3542439483, 5083.822066227664, 5109.821156259513, 5120.743962801845, 5129.692218466904, 11807.350595717233, 12122.939385303105, 12252.632421027383, 12270.38648067602, 12290.078244131726, 1813.4197056941784, 1976.8912709800954, 2123.819475344598, 2303.689001984744, 2402.0872068613817, 8375.706850260272, 8733.737987860375, 9186.678466253716, 9230.0, 9321.766955826091, 1642.531878414658, 1721.5610019445087, 1738.304678128746, 1772.503698964292, 1779.6885545029697, 61010.0, 65349.67325163344, 65353.3464665352, 65370.0, 66408.0, 9496.0, 9562.28282878787, 9651.034896510433, 9892.505374731234, 9976.301658883953, 13076.019298552646, 13104.934475327562, 13113.475460981454, 13123.343832808321, 13211.801822972662, 6068.666223357669, 6111.358307377662, 6281.183446152062, 6329.651869147241, 6359.650219237987, 5544.473275038865, 5631.465010823965, 5681.0626246668835, 5733.512651424592, 5864.266966629171, 3988.12261302513, 4102.651274641689, 4136.0, 4152.522459917148, 4261.083866968616, 1779.1904683369037, 1795.7306404039498, 1810.8732388732662, 1821.253286152671, 1866.505376075341, 742.4172024960488, 752.1613401057781, 777.700585274662, 868.9659305426522, 880.1858281089966, 15412.614684632974, 16073.678526429407, 16141.515754527383, 16180.19099045043, 16802.57993550171, 782.5891407011251, 803.2770506544157, 816.8938038055015, 832.6669332267141, 897.2821742605889, 8676.262517685942, 9080.545972701339, 9162.679306224383, 9313.860292095624, 9451.952740236255, 347696.0, 348431.0, 348798.81606511376, 354437.0, 356744.0, 55872.72063639737, 59698.0, 72824.0, 75665.0, 77982.0, 857.914208579137, 869.9304055675531, 871.1810897756089, 873.4366333714719, 877.8770972063916, 14605.0, 15220.0, 15766.9211653941, 15803.525894223192, 16134.435294764628, 34942.825285873405, 36122.63877361193, 36673.81663091668, 36807.44788828223, 37355.252894941405, 46262.7686861577, 48392.5160748388, 49669.50330496793, 49858.25212621886, 49874.0, 7310.159331676925, 7544.811379715551, 7638.121616014229, 7658.0, 7785.338246249133, 8417.158284171534, 10992.890071099187, 11298.0, 11458.312501249951, 11484.655460336204, 10093.949530252301, 10191.979691404522, 10254.487275636338, 10289.84565231507, 10537.367757934548, 10142.391456512632, 10210.540525676512, 10216.335938163995, 10327.173826094046, 10446.42544660051, 9946.403215807075, 10069.244806639384, 10270.845937311096, 10522.631707890187, 10531.210159237935, 6689.732410703517, 6690.163729533809, 6787.151606049244, 6965.303469652994, 7692.42306826979, 8270.586470676322, 9673.226141908772, 9877.40735555869, 10433.0, 10628.202884783826], "value": 7710.895970377544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1186.3652945674066, 1285.0554842190988, 1285.7107150891047, 1328.3225554966964, 1627.983720162798, 6068.089786532022, 6750.088738020366, 6949.096617439725, 6953.478489113318, 7131.037309963153, 7118.928810711891, 7190.352868241857, 7191.7842464726145, 7198.892016619755, 7216.963915180417, 1773.2375078716148, 1824.689802733532, 2016.3043749906296, 2056.969145462819, 2057.6193404220194, 2057.5267688431595, 2095.968560471594, 2102.915883364671, 2119.9682004769943, 2122.7983341582526, 1972.2012584903136, 1975.5357490989677, 1976.2490253703572, 1976.4762337980446, 1998.280618977167, 1775.6182420779464, 1819.2268285978407, 2071.9585608287825, 2092.2258764257244, 2096.517800905785, 1991.5718120603995, 2045.856790024699, 2050.3746357361, 2074.2117995161743, 2076.0657704033247, 7036.7185312587435, 7113.0753002109395, 7113.253108423644, 7118.359347658736, 7124.430045596392, 4108.198901214264, 4253.595908388698, 4259.488861336659, 4260.531341552427, 4264.019275566637, 2694.8681553747474, 2719.7688196503323, 2820.19624407043, 2820.2667306500252, 2820.5769134629763, 854.747849384433, 883.7437143228456, 919.6689191890914, 919.7056941778634, 925.4632313258294, 9464.52677366129, 9534.523273836281, 9563.187129094036, 9582.28132890036, 9586.568604412818, 3750.981245093757, 3958.8416463341146, 4019.196160767858, 4027.5166979962005, 4041.535223449282, 8170.468919520331, 8177.877331840027, 8177.918220817715, 8178.182181781894, 8179.263866252066, 4328.978355108267, 4335.393044973706, 4341.240282950471, 4351.390805287262, 4364.170807546556, 3752.512173417438, 3991.6207960243732, 4006.2988976929505, 4011.5186177658866, 4012.498437695288, 3446.4141096013236, 3448.1724386147143, 3536.7524273300623, 3541.468779683068, 3565.8573657053425, 1124.7637996020765, 1136.3125309187988, 1168.5968340922368, 1176.923499972516, 1186.5728337798387, 596.3440215762627, 738.3502517784423, 751.8984937033431, 757.0423414380813, 776.8640487914593, 4843.903121937612, 4870.6103511718975, 4938.629602779806, 4960.131976904099, 4997.675151115166, 372.61434415380495, 382.3385543010607, 383.0978046700037, 386.1485424638665, 395.566854294547, 3306.768526203191, 3314.2377253231894, 3327.068420842168, 3360.5295258663805, 3400.608929973035, 8245.257926786619, 8479.660813567512, 8575.099614540384, 8579.699710510102, 8586.65653373858, 8563.571821408905, 8567.314614830922, 8570.528620925785, 8573.399862009599, 8580.184882436159, 6594.142761440982, 6701.090189296125, 6708.1950165979415, 6714.966425167843, 6717.664116794043, 4707.693999889996, 4715.504871988392, 4745.47799742035, 4893.853184404474, 4959.256111583291, 7716.614169291625, 7823.0, 7831.021122359705, 7892.84214315722, 7894.368450524059, 7803.453758236869, 7939.761807145795, 7983.481073730189, 7987.680492780224, 8032.598370081356, 5816.621919575214, 5866.266716660418, 5915.674637894957, 5920.73356698941, 5921.911171332347, 6572.671366431564, 6718.462522998051, 6733.797986060426, 6833.248342682202, 6833.658317084027, 6317.273513546001, 6363.172787537776, 6458.806235812933, 6561.0, 6574.27682954865, 6114.296855861633, 6168.9691551541955, 6284.465820405317, 6365.427111559982, 6408.743650253938, 5745.339285982165, 5803.7388317524965, 5842.474177324061, 5862.237909071793, 5886.793962211302, 4378.868633940987, 4423.469183697976, 4476.104779044269, 4504.639628829751, 4611.815527378867, 4347.434833471629, 4415.27148020573, 4426.44669416323, 4494.70784399013, 4537.4328208973875], "value": 3742.46779456901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.30494946774013, 300.6257209773832, 305.47305897327107, 307.97536197104233, 309.25006858368465, 4813.844677277454, 4836.177849765535, 4842.709437433757, 4859.829905953292, 4867.906800075966, 4789.544993225638, 4795.865839701334, 4802.495737947517, 4803.63972702047, 4811.398575178103, 3571.910702232439, 3639.3813051781262, 3694.131879008431, 3740.382836831933, 3757.718171137162, 3760.492333534965, 3773.811309434531, 3775.3015692096915, 3790.2987947229713, 3797.9430308545393, 3724.608916063815, 3731.925361492782, 3744.0, 3754.6620804127624, 3757.9248415031684, 3618.8009659468717, 3686.262747450494, 3711.5917249102577, 3750.8499660013567, 3770.6606405423645, 3304.322613864176, 3324.9501257481156, 3333.21669407689, 3339.532465454838, 3351.8491667875005, 4680.251159814447, 4686.297055441711, 4697.895994441304, 4699.694519856198, 4705.247160454311, 4007.2586571484367, 4223.450951376332, 4297.505786834523, 4307.82768689252, 4310.82756689732, 4979.278004689299, 4992.975035124838, 5005.874853128665, 5013.573846223076, 5014.172661510846, 3575.106223444139, 3578.624244454347, 3607.693346065588, 3612.151144481045, 3616.529851119364, 5058.0, 5304.602154838364, 5336.332958380202, 5336.43967383423, 5361.758720857531, 3719.3491139050557, 3803.2963901678277, 3824.4263360495593, 3831.2337532493057, 3853.653171214548, 3900.01099439288, 3900.941485877714, 3901.122247494291, 3905.7070719696135, 3908.2769687607883, 4375.212461756914, 4380.16776812411, 4385.6710746694125, 4400.44994375703, 4407.493138289138, 4928.778204980713, 4985.376827896513, 4989.750512474362, 5020.368380276424, 5172.637915345889, 1276.527684756646, 1299.27240745183, 1301.7786976214065, 1302.3162839509143, 1307.901907356952, 840.0087896282323, 865.2731705367521, 901.4005686218591, 920.3419555018194, 925.713258570574, 4181.686373521998, 4331.350297455344, 4445.177642136216, 4457.3091170868565, 4467.798949047301, 5151.639385243072, 5184.8963020739375, 5193.883669798166, 5206.661566998133, 5234.874501982092, 4293.849715259951, 4440.600345968814, 4447.822087116544, 4447.888802779957, 4467.865964021084, 2630.0005997720746, 2645.470905818844, 2661.467706458716, 2668.479646468959, 2675.17069708391, 4635.536446355405, 4662.930056049162, 4669.855885308053, 4688.765561721969, 4689.812407503729, 4872.4640289568115, 5154.7164905929785, 5155.329807125125, 5162.586993040548, 5174.24973378858, 4592.219322715213, 4616.192166370872, 4632.374629424984, 4636.863968327714, 4697.882552936204, 5007.24891266313, 5017.498250174954, 5026.547610715053, 5045.470225626256, 5046.924296135488, 4672.415948006499, 4937.950620493749, 4956.405231372259, 4994.1759609663995, 4995.975020124876, 4596.655250856266, 4618.699784513996, 4632.4481298765295, 4634.675572709878, 4651.093051848726, 3682.8710995115043, 3689.391250443754, 3690.870819521304, 3719.832607532722, 3733.663970242691, 5062.417821950523, 5065.822696205615, 5072.365954255718, 5083.466236045162, 5090.440051594248, 4636.489986101458, 4816.325714400057, 4856.78144483492, 4858.82994095205, 4873.634477414279, 4847.394075740533, 4864.975675121602, 4873.317735517101, 4877.829275975466, 4878.707277563216, 4720.976395118139, 4736.810527578996, 4764.523547645208, 4772.832950846704, 4784.40194975628, 4670.929936050894, 4870.561649451424, 4881.29221262922, 4894.437139728977, 4923.679960802537, 4771.451283102488, 4775.498572649822, 4781.545753153445, 4800.919793046676, 4812.783424745965], "value": 3764.7903838681036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.3125630550088, 626.2359920896505, 630.2374127305957, 637.9202599675041, 700.8773464643687, 13323.800142997863, 13505.662358441032, 13542.45830166792, 13666.931665341684, 14004.789928151073, 12233.0, 12456.0, 12463.0, 12472.126951113425, 12476.50093996239, 626.7900253415112, 756.9016027916363, 771.533222400448, 772.4476998945753, 772.8338407242442, 640.6508452893161, 749.5015814483362, 764.5412752348602, 769.499825113675, 779.3726050529322, 814.2752949874616, 815.2011029191395, 815.2581151152452, 816.1063635319316, 816.302061737215, 651.1957732200729, 809.8258874342015, 810.4448452809844, 810.793247721833, 810.8459392715365, 483.23889873449457, 569.4191924237297, 582.4670426559693, 583.3845293215655, 586.4106572894214, 13208.801867971988, 13239.139455935334, 13240.404181811842, 13241.668958276025, 13255.46978120874, 12773.87040175163, 12795.48818047277, 13188.802167967488, 13254.40355184019, 13333.399997000159, 11910.940445297805, 11977.341246231541, 11999.400029998553, 12045.92828828652, 12047.0, 3976.224636195943, 4058.61443162902, 4067.959320406788, 4152.5432202457705, 4217.114405974749, 63134.0, 64491.0, 65308.346916531176, 65662.3433765661, 66314.33685663178, 9717.611295548098, 9798.46108464027, 9976.80046399068, 10000.199984001263, 10116.190704743603, 18018.0, 18019.909900450413, 18021.549461263312, 18023.819761802213, 18076.0, 6287.962486189819, 6379.553431259767, 6412.743490260431, 6466.5473416861305, 6485.254195767453, 3520.049278702843, 3584.9641503585153, 3590.4075827488696, 3606.062423769786, 3607.639236076424, 2491.7632824881607, 2567.8587677677906, 2573.4081161332997, 2575.987120064388, 2578.716341202466, 453.1322517379248, 465.6368032934317, 470.9905801883943, 476.5806090640214, 492.2517772985114, 496.4365445219702, 510.67316917173036, 511.86179731472293, 513.8432778002744, 524.8845254044104, 6999.370056694922, 7128.094016155291, 7283.927160728324, 7457.0, 7740.574268415178, 490.18139706689914, 492.91374009548184, 500.5445045009024, 504.31665093797375, 521.7730287324949, 3537.593176784703, 3661.7436779425716, 3678.356287649704, 3798.677112445473, 3914.158455931988, 53886.730566346916, 68492.31507684958, 69608.3039169612, 71148.2885171152, 73362.0, 59257.70371148117, 59592.0, 62300.37699622946, 62931.685341573, 64397.356026439134, 46708.53291467178, 55796.72101639466, 55878.44121558814, 56733.71633141808, 56984.0, 8296.700570578021, 8594.226519613265, 8664.480131191896, 8692.478451292942, 8924.776880577778, 31527.684723153394, 34902.0, 36132.4580131293, 36751.26497469982, 38200.61799381971, 46038.309425359315, 49964.500354997435, 50536.0, 51196.232056519926, 53368.73315633397, 11264.493097810782, 11294.49174787153, 11383.886161138282, 11391.430428478709, 11654.88345116538, 12195.451204695633, 12359.32023738667, 12567.685807854878, 13239.376255238818, 13490.392932317873, 10424.0, 10773.89226107729, 10919.181061420584, 10948.890511094787, 11607.071434285406, 11182.0, 11184.496697648463, 11702.122340824302, 11816.350100744541, 11855.288682679067, 11358.432078396212, 11491.885081149416, 11558.711032224262, 12231.082668799698, 12253.754924901274, 10156.746081348025, 10337.638182663572, 10407.843882341922, 10574.682759517227, 10648.787024259316, 10268.743281418025, 10407.739806504898, 10657.413842238751, 10679.51942162589, 10706.464676765974], "value": 6201.990849838552, "unit": "score"}], "name": "dromaeo_css", "value": 6110.24095159118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 116.0, 117.0, 114.0, 115.0, 116.0, 114.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 135.0, 127.0, 166.0, 133.0, 132.0, 127.0, 134.0, 157.0, 129.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 162.0, 162.0, 163.0, 161.0, 160.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 77.0, 77.0, 77.0, 86.0, 88.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 120.0, 84.0, 83.0, 84.0, 98.0, 85.0, 84.0, 111.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 63.0, 63.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 79.0, 66.0, 65.0, 66.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 92.0, 91.0, 86.0, 86.0, 86.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 145.0, 139.0, 152.0, 147.0, 135.0, 141.0, 145.0, 184.0, 138.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 181.0, 183.0, 179.0, 178.0, 177.0, 179.0, 175.0, 177.0, 180.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 71.0, 69.0, 68.0, 69.0, 72.0, 68.0, 67.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1563.6, "alertThreshold": 2.0}]} 03:11:40 INFO - Return code: 0 03:11:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:11:40 INFO - # TBPL SUCCESS # 03:11:40 INFO - Running post-action listener: _resource_record_post_action 03:11:40 INFO - [mozharness: 2016-12-07 11:11:40.799752Z] Finished run-tests step (success) 03:11:40 INFO - Running post-run listener: _resource_record_post_run 03:11:40 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 10936320; Write bytes: 416178176; Read time: 3820; Write time: 347324 03:11:40 INFO - TinderboxPrint: CPU usage
13.2% 03:11:40 INFO - TinderboxPrint: I/O read bytes / time
10,936,320 / 3,820 03:11:40 INFO - TinderboxPrint: I/O write bytes / time
416,178,176 / 347,324 03:11:40 INFO - TinderboxPrint: CPU idle
8,362.8 (86.8%) 03:11:40 INFO - TinderboxPrint: CPU user
1,213.6 (12.6%) 03:11:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:11:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 92041216; Read time: 192; Write time: 67484 03:11:40 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 8507392; Write bytes: 324136960; Read time: 3056; Write time: 279840 03:11:41 INFO - Running post-run listener: _upload_blobber_files 03:11:41 INFO - Blob upload gear active. 03:11:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:41 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 03:11:41 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:11:41 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:11:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:11:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:43 INFO - (blobuploader) - INFO - Done attempting. 03:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:46 INFO - (blobuploader) - INFO - Done attempting. 03:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:47 INFO - (blobuploader) - INFO - Done attempting. 03:11:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:47 INFO - Return code: 0 03:11:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b09ec31b8d11aed9ee23bf51b60d3d836fcd6deabf13dce7fba8cc481d37808139d260021188e6c8cf694d334dd708a29d9d9f6945b9d19bb3389133d98fc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e627905ad202aece8f5e770f2fb147d0a1776b41b9bce7c326c5c144356219cd8f6b0626c757b5b8bf377dc172c72391dbe071a69f06768fffd7287f7788c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/52d5bf2e0c68fb7e26d8335553ca3cd83933986c850c315b475aa775ded9463287cbb4460ce4882a788b7634a84506ddb35d864edea75f74bd2f234f35081ca4"} 03:11:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:47 INFO - Contents: 03:11:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b09ec31b8d11aed9ee23bf51b60d3d836fcd6deabf13dce7fba8cc481d37808139d260021188e6c8cf694d334dd708a29d9d9f6945b9d19bb3389133d98fc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e627905ad202aece8f5e770f2fb147d0a1776b41b9bce7c326c5c144356219cd8f6b0626c757b5b8bf377dc172c72391dbe071a69f06768fffd7287f7788c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/52d5bf2e0c68fb7e26d8335553ca3cd83933986c850c315b475aa775ded9463287cbb4460ce4882a788b7634a84506ddb35d864edea75f74bd2f234f35081ca4"} 03:11:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:47 INFO - Copying logs to upload dir... 03:11:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.115932 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-07 03:11:47.674129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:11:47.677996) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b09ec31b8d11aed9ee23bf51b60d3d836fcd6deabf13dce7fba8cc481d37808139d260021188e6c8cf694d334dd708a29d9d9f6945b9d19bb3389133d98fc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e627905ad202aece8f5e770f2fb147d0a1776b41b9bce7c326c5c144356219cd8f6b0626c757b5b8bf377dc172c72391dbe071a69f06768fffd7287f7788c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/52d5bf2e0c68fb7e26d8335553ca3cd83933986c850c315b475aa775ded9463287cbb4460ce4882a788b7634a84506ddb35d864edea75f74bd2f234f35081ca4"} build_url:https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/USp1NHedRAWAJlgKYWoUMw/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/Graphics/sha512/6b09ec31b8d11aed9ee23bf51b60d3d836fcd6deabf13dce7fba8cc481d37808139d260021188e6c8cf694d334dd708a29d9d9f6945b9d19bb3389133d98fc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e627905ad202aece8f5e770f2fb147d0a1776b41b9bce7c326c5c144356219cd8f6b0626c757b5b8bf377dc172c72391dbe071a69f06768fffd7287f7788c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/52d5bf2e0c68fb7e26d8335553ca3cd83933986c850c315b475aa775ded9463287cbb4460ce4882a788b7634a84506ddb35d864edea75f74bd2f234f35081ca4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:11:47.703497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:11:47.703835) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481107851.443275-1593162542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:11:47.788436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:11:47.788763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:11:47.789054) ========= ========= Total master_lag: 0.17 =========