builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1482223322.64 results: success (0) buildid: 20161219234253 builduid: 57608b53fcff45b4a14db76f6edcda37 revision: 8b08c36849a17717c8598b46b2291ca13b3e14e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.643317) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.643698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.643988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.693086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.693346) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 00:42:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.0M=0.001s 2016-12-20 00:42:03 (12.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.812550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.813049) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014537 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.864370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:02.864673) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8b08c36849a17717c8598b46b2291ca13b3e14e8 --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 8b08c36849a17717c8598b46b2291ca13b3e14e8 --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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 00:42:03,401 truncating revision to first 12 chars 2016-12-20 00:42:03,402 Setting DEBUG logging. 2016-12-20 00:42:03,402 attempt 1/10 2016-12-20 00:42:03,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8b08c36849a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 00:42:03,746 unpacking tar archive at: graphics-8b08c36849a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:03.570793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:03.571086) ========= script_repo_revision: 8b08c36849a17717c8598b46b2291ca13b3e14e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:03.571706) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:03.571973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 00:42:03.580861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-20 00:42:03.581206) ========= /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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:42:04 INFO - MultiFileLogger online at 20161220 00:42:04 in /builds/slave/test 00:42:04 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 00:42:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:42:04 INFO - {'append_to_log': False, 00:42:04 INFO - 'base_work_dir': '/builds/slave/test', 00:42:04 INFO - 'blob_upload_branch': 'Graphics', 00:42:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:42:04 INFO - 'branch': 'Graphics', 00:42:04 INFO - 'buildbot_json_path': 'buildprops.json', 00:42:04 INFO - 'config_files': ('talos/linux_config.py',), 00:42:04 INFO - 'default_actions': ('clobber', 00:42:04 INFO - 'read-buildbot-config', 00:42:04 INFO - 'download-and-extract', 00:42:04 INFO - 'populate-webroot', 00:42:04 INFO - 'create-virtualenv', 00:42:04 INFO - 'install', 00:42:04 INFO - 'run-tests'), 00:42:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:42:04 INFO - 'download_minidump_stackwalk': True, 00:42:04 INFO - 'download_symbols': 'ondemand', 00:42:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:42:04 INFO - 'tooltool.py': '/tools/tooltool.py', 00:42:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:42:04 INFO - '/tools/misc-python/virtualenv.py')}, 00:42:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:42:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:42:04 INFO - 'installer_path': 'installer.exe', 00:42:04 INFO - 'log_level': 'info', 00:42:04 INFO - 'log_name': 'talos', 00:42:04 INFO - 'log_to_console': True, 00:42:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:42:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:42:04 INFO - 'opt_config_files': (), 00:42:04 INFO - 'pip_index': False, 00:42:04 INFO - 'sps_profile': False, 00:42:04 INFO - 'sps_profile_interval': 0, 00:42:04 INFO - 'suite': 'dromaeojs', 00:42:04 INFO - 'system_bits': '32', 00:42:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:42:04 INFO - 'title': 'talos-linux64-ix-002', 00:42:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:42:04 INFO - 'use_talos_json': True, 00:42:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:42:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:42:04 INFO - 'work_dir': 'build'} 00:42:04 INFO - [mozharness: 2016-12-20 08:42:04.204909Z] Running clobber step. 00:42:04 INFO - Running pre-action listener: _resource_record_pre_action 00:42:04 INFO - Running main action method: clobber 00:42:04 INFO - rmtree: /builds/slave/test/build 00:42:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:42:05 INFO - Running post-action listener: _resource_record_post_action 00:42:05 INFO - [mozharness: 2016-12-20 08:42:05.184601Z] Finished clobber step (success) 00:42:05 INFO - [mozharness: 2016-12-20 08:42:05.184701Z] Running read-buildbot-config step. 00:42:05 INFO - Running pre-action listener: _resource_record_pre_action 00:42:05 INFO - Running main action method: read_buildbot_config 00:42:05 INFO - Using buildbot properties: 00:42:05 INFO - { 00:42:05 INFO - "project": "", 00:42:05 INFO - "product": "firefox", 00:42:05 INFO - "script_repo_revision": "default", 00:42:05 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 00:42:05 INFO - "repository": "", 00:42:05 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 00:42:05 INFO - "buildid": "20161219234253", 00:42:05 INFO - "pgo_build": "False", 00:42:05 INFO - "basedir": "/builds/slave/test", 00:42:05 INFO - "buildnumber": 25, 00:42:05 INFO - "slavename": "talos-linux64-ix-002", 00:42:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:42:05 INFO - "platform": "ubuntu64_hw", 00:42:05 INFO - "scheduler": "tests-graphics-linux64-talos", 00:42:05 INFO - "branch": "graphics", 00:42:05 INFO - "repo_path": "projects/graphics", 00:42:05 INFO - "revision": "8b08c36849a17717c8598b46b2291ca13b3e14e8", 00:42:05 INFO - "stage_platform": "linux64", 00:42:05 INFO - "builduid": "57608b53fcff45b4a14db76f6edcda37", 00:42:05 INFO - "slavebuilddir": "test" 00:42:05 INFO - } 00:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 00:42:05 INFO - Running post-action listener: _resource_record_post_action 00:42:05 INFO - [mozharness: 2016-12-20 08:42:05.187168Z] Finished read-buildbot-config step (success) 00:42:05 INFO - [mozharness: 2016-12-20 08:42:05.187259Z] Running download-and-extract step. 00:42:05 INFO - Running pre-action listener: _resource_record_pre_action 00:42:05 INFO - Running main action method: download_and_extract 00:42:05 INFO - mkdir: /builds/slave/test/build/tests 00:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:05 INFO - trying https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:42:05 INFO - Downloaded 1361 bytes. 00:42:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:42:05 INFO - Using the following test package requirements: 00:42:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:42:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:42:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:42:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'jsshell-linux-x86_64.zip'], 00:42:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:42:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:42:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:42:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:42:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:42:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:42:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:42:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:42:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:42:05 INFO - Fetch https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:42:06 INFO - Expected file size: 20258275 00:42:06 INFO - Obtained file size: 20258275 00:42:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:42:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:42:11 INFO - Expected file size: 20258275 00:42:11 INFO - Obtained file size: 20258275 00:42:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 00:42:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:42:15 INFO - Fetch https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:42:16 INFO - Expected file size: 14409734 00:42:16 INFO - Obtained file size: 14409734 00:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:17 INFO - trying https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:42:17 INFO - Downloading https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:42:19 INFO - Downloaded 55645354 bytes. 00:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:42:19 INFO - mkdir: /builds/slave/test/properties 00:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 00:42:19 INFO - Contents: 00:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:42:20 INFO - Running post-action listener: _resource_record_post_action 00:42:20 INFO - Running post-action listener: set_extra_try_arguments 00:42:20 INFO - [mozharness: 2016-12-20 08:42:20.187315Z] Finished download-and-extract step (success) 00:42:20 INFO - [mozharness: 2016-12-20 08:42:20.187544Z] Running populate-webroot step. 00:42:20 INFO - Running pre-action listener: _resource_record_pre_action 00:42:20 INFO - Running main action method: populate_webroot 00:42:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:42:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:42:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:42:20 INFO - '--tppagecycles', 00:42:20 INFO - '7'], 00:42:20 INFO - 'tests': ['tsvgm']}}, 00:42:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:42:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:42:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:42:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:42:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:42:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:42:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['damp', 'tps']}, 00:42:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'tests': ['damp', 'tps']}, 00:42:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['dromaeo_dom']}, 00:42:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:42:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['basic_compositor_video']}, 00:42:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:42:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'other-e10s': {'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['a11yr', 00:42:20 INFO - 'ts_paint', 00:42:20 INFO - 'tpaint', 00:42:20 INFO - 'sessionrestore', 00:42:20 INFO - 'sessionrestore_no_auto_restore', 00:42:20 INFO - 'tabpaint']}, 00:42:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['tsvgx', 00:42:20 INFO - 'tsvgr_opacity', 00:42:20 INFO - 'tart', 00:42:20 INFO - 'tscrollx', 00:42:20 INFO - 'cart', 00:42:20 INFO - 'tsvg_static']}, 00:42:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:42:20 INFO - 'tsvgr_opacity', 00:42:20 INFO - 'tart', 00:42:20 INFO - 'tscrollx', 00:42:20 INFO - 'cart', 00:42:20 INFO - 'tsvg_static']}, 00:42:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'talos_options': ['--disable-e10s'], 00:42:20 INFO - 'tests': ['tp5o']}, 00:42:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:42:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'talos_options': ['--disable-e10s', 00:42:20 INFO - '--xperf_path', 00:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:42:20 INFO - 'tests': ['tp5n']}, 00:42:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:42:20 INFO - 'talos_options': ['--xperf_path', 00:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:42:20 INFO - 'tests': ['tp5n']}}, 00:42:20 INFO - 'talos.zip': {'path': '', 00:42:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:42:20 INFO - Running post-action listener: _resource_record_post_action 00:42:20 INFO - [mozharness: 2016-12-20 08:42:20.206378Z] Finished populate-webroot step (success) 00:42:20 INFO - [mozharness: 2016-12-20 08:42:20.206467Z] Running create-virtualenv step. 00:42:20 INFO - Running pre-action listener: _resource_record_pre_action 00:42:20 INFO - Running main action method: create_virtualenv 00:42:20 INFO - Creating virtualenv /builds/slave/test/build/venv 00:42:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:42:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:42:20 INFO - Using real prefix '/usr' 00:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:42:20 INFO - Installing distribute.............................................................................................................................................................................................done. 00:42:22 INFO - Installing pip.................done. 00:42:22 INFO - Return code: 0 00:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:42:22 INFO - Reading from file tmpfile_stdout 00:42:22 INFO - Output received: 00:42:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:42:22 INFO - Using env: {'DISPLAY': ':0', 00:42:22 INFO - 'HOME': '/home/cltbld', 00:42:22 INFO - 'LANG': 'en_US.UTF-8', 00:42:22 INFO - 'LANGUAGE': 'en_US:en', 00:42:22 INFO - 'LOGNAME': 'cltbld', 00:42:22 INFO - 'MAIL': '/var/mail/cltbld', 00:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:22 INFO - 'MOZ_NO_REMOTE': '1', 00:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:22 INFO - 'NO_EM_RESTART': '1', 00:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:22 INFO - 'PWD': '/builds/slave/test', 00:42:22 INFO - 'SHELL': '/bin/bash', 00:42:23 INFO - 'SHLVL': '1', 00:42:23 INFO - 'TERM': 'linux', 00:42:23 INFO - 'TMOUT': '86400', 00:42:23 INFO - 'USER': 'cltbld', 00:42:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:23 INFO - '_': '/tools/buildbot/bin/python'} 00:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:42:23 INFO - Cleaning up... 00:42:23 INFO - Return code: 0 00:42:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:42:23 INFO - Using env: {'DISPLAY': ':0', 00:42:23 INFO - 'HOME': '/home/cltbld', 00:42:23 INFO - 'LANG': 'en_US.UTF-8', 00:42:23 INFO - 'LANGUAGE': 'en_US:en', 00:42:23 INFO - 'LOGNAME': 'cltbld', 00:42:23 INFO - 'MAIL': '/var/mail/cltbld', 00:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:23 INFO - 'MOZ_NO_REMOTE': '1', 00:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:23 INFO - 'NO_EM_RESTART': '1', 00:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:23 INFO - 'PWD': '/builds/slave/test', 00:42:23 INFO - 'SHELL': '/bin/bash', 00:42:23 INFO - 'SHLVL': '1', 00:42:23 INFO - 'TERM': 'linux', 00:42:23 INFO - 'TMOUT': '86400', 00:42:23 INFO - 'USER': 'cltbld', 00:42:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:23 INFO - '_': '/tools/buildbot/bin/python'} 00:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:23 INFO - Downloading/unpacking psutil>=3.1.1 00:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:42:25 INFO - Installing collected packages: psutil 00:42:25 INFO - Running setup.py install for psutil 00:42:25 INFO - building 'psutil._psutil_linux' extension 00:42:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:42:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:42:25 INFO - building 'psutil._psutil_posix' extension 00:42:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:42:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:42:26 INFO - Successfully installed psutil 00:42:26 INFO - Cleaning up... 00:42:26 INFO - Return code: 0 00:42:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:26 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:42:26 INFO - Using env: {'DISPLAY': ':0', 00:42:26 INFO - 'HOME': '/home/cltbld', 00:42:26 INFO - 'LANG': 'en_US.UTF-8', 00:42:26 INFO - 'LANGUAGE': 'en_US:en', 00:42:26 INFO - 'LOGNAME': 'cltbld', 00:42:26 INFO - 'MAIL': '/var/mail/cltbld', 00:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:26 INFO - 'MOZ_NO_REMOTE': '1', 00:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:26 INFO - 'NO_EM_RESTART': '1', 00:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:26 INFO - 'PWD': '/builds/slave/test', 00:42:26 INFO - 'SHELL': '/bin/bash', 00:42:26 INFO - 'SHLVL': '1', 00:42:26 INFO - 'TERM': 'linux', 00:42:26 INFO - 'TMOUT': '86400', 00:42:26 INFO - 'USER': 'cltbld', 00:42:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:26 INFO - '_': '/tools/buildbot/bin/python'} 00:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:42:28 INFO - Installing collected packages: mozsystemmonitor 00:42:28 INFO - Running setup.py install for mozsystemmonitor 00:42:28 INFO - Successfully installed mozsystemmonitor 00:42:28 INFO - Cleaning up... 00:42:28 INFO - Return code: 0 00:42:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:42: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')]} 00:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42: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')]} 00:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:42:28 INFO - Using env: {'DISPLAY': ':0', 00:42:28 INFO - 'HOME': '/home/cltbld', 00:42:28 INFO - 'LANG': 'en_US.UTF-8', 00:42:28 INFO - 'LANGUAGE': 'en_US:en', 00:42:28 INFO - 'LOGNAME': 'cltbld', 00:42:28 INFO - 'MAIL': '/var/mail/cltbld', 00:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:28 INFO - 'MOZ_NO_REMOTE': '1', 00:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:28 INFO - 'NO_EM_RESTART': '1', 00:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:28 INFO - 'PWD': '/builds/slave/test', 00:42:28 INFO - 'SHELL': '/bin/bash', 00:42:28 INFO - 'SHLVL': '1', 00:42:28 INFO - 'TERM': 'linux', 00:42:28 INFO - 'TMOUT': '86400', 00:42:28 INFO - 'USER': 'cltbld', 00:42:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:28 INFO - '_': '/tools/buildbot/bin/python'} 00:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:28 INFO - Downloading/unpacking jsonschema==2.5.1 00:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:42:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:31 INFO - Downloading functools32-3.2.3-2.tar.gz 00:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:42:31 INFO - warning: no files found matching '*.txt' 00:42:31 INFO - no previously-included directories found matching 'build' 00:42:31 INFO - no previously-included directories found matching 'dist' 00:42:31 INFO - no previously-included directories found matching '.git*' 00:42:31 INFO - Installing collected packages: jsonschema, functools32 00:42:31 INFO - Running setup.py install for functools32 00:42:31 INFO - warning: no files found matching '*.txt' 00:42:31 INFO - no previously-included directories found matching 'build' 00:42:31 INFO - no previously-included directories found matching 'dist' 00:42:31 INFO - no previously-included directories found matching '.git*' 00:42:31 INFO - Successfully installed jsonschema functools32 00:42:31 INFO - Cleaning up... 00:42:31 INFO - Return code: 0 00:42:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:31 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:42:31 INFO - Using env: {'DISPLAY': ':0', 00:42:31 INFO - 'HOME': '/home/cltbld', 00:42:31 INFO - 'LANG': 'en_US.UTF-8', 00:42:31 INFO - 'LANGUAGE': 'en_US:en', 00:42:31 INFO - 'LOGNAME': 'cltbld', 00:42:31 INFO - 'MAIL': '/var/mail/cltbld', 00:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:31 INFO - 'MOZ_NO_REMOTE': '1', 00:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:31 INFO - 'NO_EM_RESTART': '1', 00:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:31 INFO - 'PWD': '/builds/slave/test', 00:42:31 INFO - 'SHELL': '/bin/bash', 00:42:31 INFO - 'SHLVL': '1', 00:42:31 INFO - 'TERM': 'linux', 00:42:31 INFO - 'TMOUT': '86400', 00:42:31 INFO - 'USER': 'cltbld', 00:42:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:31 INFO - '_': '/tools/buildbot/bin/python'} 00:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:42:31 INFO - Cleaning up... 00:42:31 INFO - Return code: 0 00:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:31 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:42:31 INFO - Using env: {'DISPLAY': ':0', 00:42:31 INFO - 'HOME': '/home/cltbld', 00:42:31 INFO - 'LANG': 'en_US.UTF-8', 00:42:31 INFO - 'LANGUAGE': 'en_US:en', 00:42:31 INFO - 'LOGNAME': 'cltbld', 00:42:31 INFO - 'MAIL': '/var/mail/cltbld', 00:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:31 INFO - 'MOZ_NO_REMOTE': '1', 00:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:31 INFO - 'NO_EM_RESTART': '1', 00:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:31 INFO - 'PWD': '/builds/slave/test', 00:42:31 INFO - 'SHELL': '/bin/bash', 00:42:31 INFO - 'SHLVL': '1', 00:42:31 INFO - 'TERM': 'linux', 00:42:31 INFO - 'TMOUT': '86400', 00:42:31 INFO - 'USER': 'cltbld', 00:42:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:31 INFO - '_': '/tools/buildbot/bin/python'} 00:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:31 INFO - Downloading/unpacking blobuploader==1.2.4 00:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:33 INFO - Downloading blobuploader-1.2.4.tar.gz 00:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:42:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:42:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:34 INFO - Downloading docopt-0.6.1.tar.gz 00:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 00:42:34 INFO - Running setup.py install for blobuploader 00:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:42:34 INFO - Running setup.py install for requests 00:42:35 INFO - Running setup.py install for docopt 00:42:35 INFO - Successfully installed blobuploader requests docopt 00:42:35 INFO - Cleaning up... 00:42:35 INFO - Return code: 0 00:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:35 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:42:35 INFO - Using env: {'DISPLAY': ':0', 00:42:35 INFO - 'HOME': '/home/cltbld', 00:42:35 INFO - 'LANG': 'en_US.UTF-8', 00:42:35 INFO - 'LANGUAGE': 'en_US:en', 00:42:35 INFO - 'LOGNAME': 'cltbld', 00:42:35 INFO - 'MAIL': '/var/mail/cltbld', 00:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:35 INFO - 'MOZ_NO_REMOTE': '1', 00:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:35 INFO - 'NO_EM_RESTART': '1', 00:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:35 INFO - 'PWD': '/builds/slave/test', 00:42:35 INFO - 'SHELL': '/bin/bash', 00:42:35 INFO - 'SHLVL': '1', 00:42:35 INFO - 'TERM': 'linux', 00:42:35 INFO - 'TMOUT': '86400', 00:42:35 INFO - 'USER': 'cltbld', 00:42:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:35 INFO - '_': '/tools/buildbot/bin/python'} 00:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:35 INFO - Running setup.py (path:/tmp/pip-M3mLbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:35 INFO - Running setup.py (path:/tmp/pip-IBWUcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:35 INFO - Running setup.py (path:/tmp/pip-d4HK1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:35 INFO - Running setup.py (path:/tmp/pip-_gffkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:35 INFO - Running setup.py (path:/tmp/pip-U2QOGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:35 INFO - Running setup.py (path:/tmp/pip-DvJw7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:35 INFO - Running setup.py (path:/tmp/pip-0IoVr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:35 INFO - Running setup.py (path:/tmp/pip-WStCPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:35 INFO - Running setup.py (path:/tmp/pip-XPi1xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:36 INFO - Running setup.py (path:/tmp/pip-XWQCmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:36 INFO - Running setup.py (path:/tmp/pip-oIvbOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:36 INFO - Running setup.py (path:/tmp/pip-IHzmaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:36 INFO - Running setup.py (path:/tmp/pip-NQ0DRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:36 INFO - Running setup.py (path:/tmp/pip-ih2zVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:36 INFO - Running setup.py (path:/tmp/pip-MN2QHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:36 INFO - Running setup.py (path:/tmp/pip-m4h_4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:36 INFO - Running setup.py (path:/tmp/pip-IeR5bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:42:36 INFO - Running setup.py install for manifestparser 00:42:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:42:36 INFO - Running setup.py install for mozcrash 00:42:36 INFO - Running setup.py install for mozdebug 00:42:36 INFO - Running setup.py install for mozdevice 00:42:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozfile 00:42:37 INFO - Running setup.py install for mozhttpd 00:42:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozinfo 00:42:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozInstall 00:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozleak 00:42:37 INFO - Running setup.py install for mozlog 00:42:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for moznetwork 00:42:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozprocess 00:42:37 INFO - Running setup.py install for mozprofile 00:42:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:42:37 INFO - Running setup.py install for mozrunner 00:42:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:42:38 INFO - Running setup.py install for mozscreenshot 00:42:38 INFO - Running setup.py install for moztest 00:42:38 INFO - Running setup.py install for mozversion 00:42:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:42:38 INFO - Cleaning up... 00:42:38 INFO - Return code: 0 00:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:38 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:42:38 INFO - Using env: {'DISPLAY': ':0', 00:42:38 INFO - 'HOME': '/home/cltbld', 00:42:38 INFO - 'LANG': 'en_US.UTF-8', 00:42:38 INFO - 'LANGUAGE': 'en_US:en', 00:42:38 INFO - 'LOGNAME': 'cltbld', 00:42:38 INFO - 'MAIL': '/var/mail/cltbld', 00:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:38 INFO - 'MOZ_NO_REMOTE': '1', 00:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:38 INFO - 'NO_EM_RESTART': '1', 00:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:38 INFO - 'PWD': '/builds/slave/test', 00:42:38 INFO - 'SHELL': '/bin/bash', 00:42:38 INFO - 'SHLVL': '1', 00:42:38 INFO - 'TERM': 'linux', 00:42:38 INFO - 'TMOUT': '86400', 00:42:38 INFO - 'USER': 'cltbld', 00:42:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:38 INFO - '_': '/tools/buildbot/bin/python'} 00:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:38 INFO - Running setup.py (path:/tmp/pip-hDb2Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:38 INFO - Running setup.py (path:/tmp/pip-o1Fbzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:38 INFO - Running setup.py (path:/tmp/pip-Ye5wD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:38 INFO - Running setup.py (path:/tmp/pip-LmH3cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:38 INFO - Running setup.py (path:/tmp/pip-JUs_VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:39 INFO - Running setup.py (path:/tmp/pip-ws57fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:39 INFO - Running setup.py (path:/tmp/pip-hJ1mAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:39 INFO - Running setup.py (path:/tmp/pip-lmpYax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:39 INFO - Running setup.py (path:/tmp/pip-yHxOlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:39 INFO - Running setup.py (path:/tmp/pip-hGwlEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:39 INFO - Running setup.py (path:/tmp/pip-IB8XlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:39 INFO - Running setup.py (path:/tmp/pip-OZCFMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:39 INFO - Running setup.py (path:/tmp/pip-P2W75d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:39 INFO - Running setup.py (path:/tmp/pip-xExLeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:39 INFO - Running setup.py (path:/tmp/pip-trDVsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:39 INFO - Running setup.py (path:/tmp/pip-_tXOQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:39 INFO - Running setup.py (path:/tmp/pip-mMIjD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:42:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:41 INFO - Downloading blessings-1.6.tar.gz 00:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:42:41 INFO - Installing collected packages: blessings 00:42:41 INFO - Running setup.py install for blessings 00:42:42 INFO - Successfully installed blessings 00:42:42 INFO - Cleaning up... 00:42:42 INFO - Return code: 0 00:42:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:42 INFO - Reading from file tmpfile_stdout 00:42:42 INFO - Current package versions: 00:42:42 INFO - argparse == 1.2.1 00:42:42 INFO - blessings == 1.6 00:42:42 INFO - blobuploader == 1.2.4 00:42:42 INFO - docopt == 0.6.1 00:42:42 INFO - functools32 == 3.2.3-2 00:42:42 INFO - jsonschema == 2.5.1 00:42:42 INFO - manifestparser == 1.1 00:42:42 INFO - mozInstall == 1.12 00:42:42 INFO - mozcrash == 1.0 00:42:42 INFO - mozdebug == 0.1 00:42:42 INFO - mozdevice == 0.49 00:42:42 INFO - mozfile == 1.2 00:42:42 INFO - mozhttpd == 0.7 00:42:42 INFO - mozinfo == 0.9 00:42:42 INFO - mozleak == 0.1 00:42:42 INFO - mozlog == 3.4 00:42:42 INFO - moznetwork == 0.27 00:42:42 INFO - mozprocess == 0.23 00:42:42 INFO - mozprofile == 0.28 00:42:42 INFO - mozrunner == 6.13 00:42:42 INFO - mozscreenshot == 0.1 00:42:42 INFO - mozsystemmonitor == 0.3 00:42:42 INFO - moztest == 0.7 00:42:42 INFO - mozversion == 1.4 00:42:42 INFO - psutil == 3.1.1 00:42:42 INFO - requests == 1.2.3 00:42:42 INFO - wsgiref == 0.1.2 00:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:42 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:42:42 INFO - Using env: {'DISPLAY': ':0', 00:42:42 INFO - 'HOME': '/home/cltbld', 00:42:42 INFO - 'LANG': 'en_US.UTF-8', 00:42:42 INFO - 'LANGUAGE': 'en_US:en', 00:42:42 INFO - 'LOGNAME': 'cltbld', 00:42:42 INFO - 'MAIL': '/var/mail/cltbld', 00:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:42 INFO - 'MOZ_NO_REMOTE': '1', 00:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:42 INFO - 'NO_EM_RESTART': '1', 00:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:42 INFO - 'PWD': '/builds/slave/test', 00:42:42 INFO - 'SHELL': '/bin/bash', 00:42:42 INFO - 'SHLVL': '1', 00:42:42 INFO - 'TERM': 'linux', 00:42:42 INFO - 'TMOUT': '86400', 00:42:42 INFO - 'USER': 'cltbld', 00:42:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:42 INFO - '_': '/tools/buildbot/bin/python'} 00:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:42:42 INFO - Cleaning up... 00:42:42 INFO - Return code: 0 00:42:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:42 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 0xfac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:42:42 INFO - Using env: {'DISPLAY': ':0', 00:42:42 INFO - 'HOME': '/home/cltbld', 00:42:42 INFO - 'LANG': 'en_US.UTF-8', 00:42:42 INFO - 'LANGUAGE': 'en_US:en', 00:42:42 INFO - 'LOGNAME': 'cltbld', 00:42:42 INFO - 'MAIL': '/var/mail/cltbld', 00:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:42 INFO - 'MOZ_NO_REMOTE': '1', 00:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:42 INFO - 'NO_EM_RESTART': '1', 00:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:42 INFO - 'PWD': '/builds/slave/test', 00:42:42 INFO - 'SHELL': '/bin/bash', 00:42:42 INFO - 'SHLVL': '1', 00:42:42 INFO - 'TERM': 'linux', 00:42:42 INFO - 'TMOUT': '86400', 00:42:42 INFO - 'USER': 'cltbld', 00:42:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:42 INFO - '_': '/tools/buildbot/bin/python'} 00:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:42:42 INFO - Cleaning up... 00:42:42 INFO - Return code: 0 00:42:42 INFO - Running post-action listener: _resource_record_post_action 00:42:42 INFO - Running post-action listener: _start_resource_monitoring 00:42:42 INFO - Starting resource monitoring. 00:42:42 INFO - [mozharness: 2016-12-20 08:42:42.857363Z] Finished create-virtualenv step (success) 00:42:42 INFO - [mozharness: 2016-12-20 08:42:42.857842Z] Running install step. 00:42:42 INFO - Running pre-action listener: _resource_record_pre_action 00:42:42 INFO - Running main action method: install 00:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:43 INFO - Reading from file tmpfile_stdout 00:42:43 INFO - Detecting whether we're running mozinstall >=1.0... 00:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:42:43 INFO - Reading from file tmpfile_stdout 00:42:43 INFO - Output received: 00:42:43 INFO - Usage: mozinstall [options] installer 00:42:43 INFO - Options: 00:42:43 INFO - -h, --help show this help message and exit 00:42:43 INFO - -d DEST, --destination=DEST 00:42:43 INFO - Directory to install application into. [default: 00:42:43 INFO - "/builds/slave/test"] 00:42:43 INFO - --app=APP Application being installed. [default: firefox] 00:42:43 INFO - mkdir: /builds/slave/test/build/application 00:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:42:59 INFO - Reading from file tmpfile_stdout 00:42:59 INFO - Output received: 00:42:59 INFO - /builds/slave/test/build/application/firefox/firefox 00:42:59 INFO - Running post-action listener: _resource_record_post_action 00:42:59 INFO - [mozharness: 2016-12-20 08:42:59.185287Z] Finished install step (success) 00:42:59 INFO - [mozharness: 2016-12-20 08:42:59.185535Z] Running run-tests step. 00:42:59 INFO - Running pre-action listener: _resource_record_pre_action 00:42:59 INFO - Running main action method: run_tests 00:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:42:59 INFO - Python 2.7.3 00:42:59 INFO - Return code: 0 00:42:59 INFO - grabbing minidump binary from tooltool 00:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:59 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 0x131b3f0>, '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 0x131bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131c1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:42:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:42:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:42:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:42:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:42:59 INFO - Return code: 0 00:42:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:42:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:42:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:42:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:42:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:42:59 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/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:42:59 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/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:42:59 INFO - Using env: {'DISPLAY': ':0', 00:42:59 INFO - 'HOME': '/home/cltbld', 00:42:59 INFO - 'LANG': 'en_US.UTF-8', 00:42:59 INFO - 'LANGUAGE': 'en_US:en', 00:42:59 INFO - 'LOGNAME': 'cltbld', 00:42:59 INFO - 'MAIL': '/var/mail/cltbld', 00:42:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:42:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:59 INFO - 'MOZ_NO_REMOTE': '1', 00:42:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:59 INFO - 'NO_EM_RESTART': '1', 00:42:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:59 INFO - 'PWD': '/builds/slave/test', 00:42:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:42:59 INFO - 'SHELL': '/bin/bash', 00:42:59 INFO - 'SHLVL': '1', 00:42:59 INFO - 'TERM': 'linux', 00:42:59 INFO - 'TMOUT': '86400', 00:42:59 INFO - 'USER': 'cltbld', 00:42:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975', 00:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:59 INFO - '_': '/tools/buildbot/bin/python'} 00:42:59 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/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:42:59 INFO - mozversion application_buildid: 20161219234253 00:42:59 INFO - mozversion application_changeset: 8b08c36849a17717c8598b46b2291ca13b3e14e8 00:42:59 INFO - mozversion application_display_name: Nightly 00:42:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:42:59 INFO - mozversion application_name: Firefox 00:42:59 INFO - mozversion application_remotingname: firefox 00:42:59 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 00:42:59 INFO - mozversion application_vendor: Mozilla 00:42:59 INFO - mozversion application_version: 53.0a1 00:42:59 INFO - mozversion platform_buildid: 20161219234253 00:42:59 INFO - mozversion platform_changeset: 8b08c36849a17717c8598b46b2291ca13b3e14e8 00:42:59 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 00:42:59 INFO - mozversion platform_version: 53.0a1 00:42:59 INFO - using testdate: 1482223379 00:42:59 INFO - actual date: 1482223379 00:42:59 INFO - starting webserver on 'localhost:42426' 00:42:59 INFO - SUITE-START | Running 2 tests 00:42:59 INFO - TEST-START | dromaeo_css 00:42:59 INFO - operating with platform_type : linux_ 00:42:59 INFO - Initialising browser for dromaeo_css test... 00:42:59 INFO - TEST-INFO | started process 10033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNafZmj/profile http://localhost:42426/getInfo.html) 00:43:03 INFO - PROCESS | 10033 | __metrics Screen width/height:1600/1200 00:43:03 INFO - PROCESS | 10033 | colorDepth:24 00:43:03 INFO - PROCESS | 10033 | Browser inner width/height: 1024/697 00:43:03 INFO - PROCESS | 10033 | __metrics 00:43:04 INFO - PROCESS | 10033 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:43:04 INFO - PROCESS | 10033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:43:04 INFO - PROCESS | 10033 | console.error: PushService: 00:43:04 INFO - PROCESS | 10033 | stateChangeProcessEnqueue: Error transitioning state 00:43:04 INFO - PROCESS | 10033 | UnknownError 00:43:05 INFO - TEST-INFO | 10033: exit 0 00:43:05 INFO - Browser initialized. 00:43:05 INFO - Running cycle 1/1 for dromaeo_css test... 00:43:05 INFO - TEST-INFO | started process 10113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNafZmj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:17 INFO - PROCESS | 10113 | RSS: Main: 155803648 00:43:17 INFO - PROCESS | 10113 | 00:44:08 INFO - PROCESS | 10113 | 1482223448224 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:46:22 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42426/tests/dromaeo/cssquery-ext.html) 00:46:23 INFO - PROCESS | 10113 | RSS: Main: 290463744 00:46:23 INFO - PROCESS | 10113 | 00:49:26 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-ext.html (next: http://localhost:42426/tests/dromaeo/cssquery-jquery.html) 00:49:26 INFO - PROCESS | 10113 | RSS: Main: 248684544 00:49:26 INFO - PROCESS | 10113 | 00:52:29 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42426/tests/dromaeo/cssquery-mootools.html) 00:52:29 INFO - PROCESS | 10113 | RSS: Main: 188706816 00:52:29 INFO - PROCESS | 10113 | 00:55:32 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42426/tests/dromaeo/cssquery-prototype.html) 00:55:32 INFO - PROCESS | 10113 | RSS: Main: 188047360 00:55:32 INFO - PROCESS | 10113 | 00:58:36 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42426/tests/dromaeo/cssquery-yui.html) 00:58:36 INFO - PROCESS | 10113 | RSS: Main: 188653568 00:58:36 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | Cycle 1(1): loaded http://localhost:42426/tests/dromaeo/cssquery-yui.html (next: http://localhost:42426/tests/dromaeo/cssquery-dojo.html) 01:01:40 INFO - PROCESS | 10113 | RSS: Main: 281165824 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | __start_tp_report 01:01:40 INFO - PROCESS | 10113 | _x_x_mozilla_page_load 01:01:40 INFO - PROCESS | 10113 | _x_x_mozilla_page_load_details 01:01:40 INFO - PROCESS | 10113 | |i|pagename|runs| 01:01:40 INFO - PROCESS | 10113 | |0;dojo.html;2585.7155712871586;2621.619865119559;2632.144553020268;2648.0864101884854;2661.361273294409;4604.401427814388;4680.672352935296;4736.242201247801;4740.620750339973;4765.499622539631;4664.300354946759;4674.836380726675;4696.530346965302;4742.6205903527725;4767.427908650958;4283.635890949257;4303.505096913848;4354.194474022316;4355.499117601469;4460.286354183331;4307.267764480031;4335.783210839445;4444.133393988173;4471.105778844244;4519.480259770119;4210.263203939329;4251.383549385322;4434.4678638563255;4480.059187570614;4530.478994915594;4264.808083636244;4286.892827679302;4287.485501739811;4291.184674911757;4299.484061912591;4263.701540892139;4264.23243816113;4284.550122237182;4290.592393722592;4309.719868208588;4689.155951928651;4721.220998535237;4730.101280756645;4777.784999674988;4778.80884764609;5059.06407314648;5059.2916991621205;5075.137226671474;5077.822276220315;5123.538881500645;4941.777620007108;4983.950160498421;4988.5260900214425;5059.114654935372;5106.004329155816;4754.453237877619;4774.355462012653;4775.570198682135;4822.71063736177;4826.806927722922;5176.352955880515;5221.086309895829;5225.529702326809;5232.686038837682;5277.261183434322;4832.734199619054;4870.9269360959615;5016.724080175552;5018.698878067327;5018.974905125524;5005.674631148963;5010.3737032870895;5049.394072711299;5058.114829904752;5131.2559678846355;5007.198848184273;5033.270175824485;5043.167877300204;5044.545990860766;5091.821786237464;5008.524190201925;5027.723475208825;5040.722760248222;5041.369828771403;5086.160783470686;4095.4675892133832;4121.278776214151;4122.072533679898;4180.143070670566;4202.978985105116;3698.2418604186078;3707.870224542182;3732.9626703733156;3737.32728108943;3745.194783121642;4324.481062272547;4333.891652708708;4340.500842403101;4355.803988820448;4380.408644832907;4939.185034469272;4976.800927962913;5085.847424577269;5094.133997220481;5094.719790411563;4287.206866729665;4346.043870348518;4358.150160718693;4363.650907927358;4425.22558552252;4578.153041687298;4591.517890621437;4598.333241680005;4602.516735742699;4610.10103029906;4756.7145971241835;4759.095771803346;4759.4764575896625;4764.833230836974;4806.855794326176;4921.655484116078;4986.576141027908;5059.873503162303;5081.11080560893;5101.821436249714;4760.047990401864;4761.333413322069;4764.094821983812;4795.568398844121;4810.5670489656095;5014.598832093497;5014.874628134326;5015.448300686994;5016.673916195436;5050.191969284897;4866.270059491105;4909.140900342354;5003.674761140514;5020.096382651158;5036.320096787033;4922.212446008622;4932.53140951609;4934.111859865258;4966.428860681068;4982.7259500727805;4958.504149585013;4970.975145124396;4973.204287314013;4978.327925730125;4984.40187177541;4677.064587082529;4754.833580824655;4829.589484893823;4900.730459824744;4936.481669424802;4910.680805747615;4970.9254361183885;4974.32846565709;5011.949880501148;5012.724300163526;4689.320048593003;4856.78144483492;4859.902801943871;4903.215485522299;4903.8528844134735 01:01:40 INFO - PROCESS | 10113 | |1;ext.html;509.9770510327035;541.8536995011347;544.2706772924281;551.5394645471032;559.3846768554588;24516.264512064645;35324.646753532455;37452.62547374522;37535;41234;37392;37802.24395512088;37813;37816.24367512648;37828.62171378286;7542.4720269581285;7722.575258360788;7729.72945946892;7733.7293194738195;7735;7273.927260727378;7485.5508669480005;9351.345405821596;9688.321817472779;9692;9953.601855925754;10020.59917603295;10023.09792118709;10026.09765121139;10027.247956403298;9852.556634951408;9912.702618921372;9924.801503969953;9927.702168934944;9931.553080111413;7219.675114619855;7428.3685886699695;9470.38442501242;9777.120059194707;9786.608535658635;36033.63966360329;36358.8182059088;36431;36440.088997775005;36478.270434591424;2826.2651710555197;2870.2250392393935;2906.404187141652;2928.531434970416;3531.099569609759;26883.32791680204;27047.729522704718;27154.5926811098;27363.17910462689;28017.57973630397;3397.303552771676;3460.7058400036026;3480.5823301203764;3499.317633061554;3549.1304630365726;234603.99999999828;235233;235654;236052;236957;40854.79572602177;40963.59036409598;41065.38401923973;41099.1780164395;41208.793956030626;52525;52606;52634.89428927046;52713.2093018605;52806.735966319924;13148.802767958488;13325.13386629866;13346.46614135443;13351.93324033393;13360.06479546442;8981.05698901619;9829.606815727433;9849.803003939882;9853;9855.507224638739;13438.126521776054;14449.855501445061;14860.582066124853;14996.325165367585;15407.460738874086;6032.487238584682;6116.938830611637;6129.172561704113;6281.937180628135;6379.681015949184;750.6584504050644;787.6219414680985;924.1359329027381;941.9858702119474;943.9764005899907;25023.62464563033;26585.202443926326;26906.461870762865;27003.459930801666;27025.324366890985;904.1230006893303;928.7492377058156;960.2893858544627;966.8163049020663;972.4748635736764;13383.397747101404;14156;14334.093096792676;14481.92759036198;14483.49307774244;317054;318787;319366;319528;320453;46715.76642116836;46717.29924051142;46755.76622116868;46805;46908;1024.861643678094;1121.287982131336;1138.3056335635422;1140.0765380042192;1149.0749946293315;25199.73202411792;26079;26484.02731660892;26842.194734158005;27077;40587.594124059564;40671.796641016605;40855.38716919308;41090.38364424596;41121.794391027855;280803;281869;282091;282212;282651;29251;29910.401791964476;30114.84942575273;30415.239619009702;30556.388872221985;39225;39452.605473944895;39609.2078158441;40400.39399408952;40668;33482.66517334795;33888;33981.49027764635;34449.48325775166;34751.826240868635;33616.83191584027;33907.321853563284;34238.657613423544;34478.65521344754;35288.11779705425;33147;33957.49063764095;34108.14729631779;34692.47961280633;34719.305613888086;29129.85435072811;31147.532787008666;31331.84334078315;31537.21156971094;31620.683793161774;23243;23398.64902026505;23652.52694946126;23702.407439814142;23786.40533986664 01:01:40 INFO - PROCESS | 10113 | |2;jquery.html;348.15398581447073;365.7768761055754;372.35210733324016;375.27009965616867;396.46477255704804;12320.137590368679;15333.23333833308;15628;15758.921205393957;16356;15779.842201577982;15931.123788191644;16107.194640267999;16230.83769162311;16312.184390780443;4912.778924948368;4930.186519224324;5091.389033316007;5120.590352771788;5137.743112844361;3658.176910195198;3863.594322596129;5027.572656324217;5082.51716086973;5127.589792816584;5682.204491371212;5934.940650593482;5943.375945525722;6040.0939859021055;6040.96979515104;5808.099744539603;5897.085951677497;5935.881282374328;6027.126066720323;6038.305594856603;5230.372355317349;5234.214867769827;5235.947640523584;5237.921431178497;5238.869028274324;19401.32095376669;19814.603707925762;19878.60242795136;19913.203471861107;19973.800261997338;1840.530664680498;1919.9040047997544;1945.6886898096236;1974.2103158736477;2023.6155130525153;12112.697182570506;12948.093633445662;13146.868531314756;13531.188128712309;13544.119632223874;1704.207543492282;1769.5841477252836;1817.690992531273;1825.607494388713;1844.8155184481445;62591.6870415645;64879;65460;66692.66653666749;67150.32849671441;9250.352475326798;9257.67598134062;9401.153896149242;9637.951810240904;9805.55874985613;13079.607611771662;13084.934575327254;13089.476420943247;13106.737865242641;13112.737745245042;6873.450123990069;7001.214690254054;7002.579845209304;7209.6034718091005;7215;6659.4006539411685;6703.3296670332575;6894.310568943166;6936.514443988974;6959.652017399211;5924.297314178639;6011.458968692751;6023.397660234029;6054.7275372607455;6180.629162250189;1718.7507811367282;1735.5227312489167;1754.1229385307347;1767.478593814802;1770.4157627982993;794.66226853587;817.3992115794886;853.6286715278874;904.4844438669895;944.1031020530523;15752.133632650315;16371.508854734138;16694.58263543421;16951.49145525636;17724.29102835898;862.7498025572513;864.6152462154407;866.9046404895456;877.591919757316;937.5499760115183;5226.895462090737;5373.7581808818695;9294.72115836526;9936.205103591696;10065.496725163712;224438;225072.7463626845;259345;347141;361337;63161;76313.61843190748;76749.23250767532;76963.61518192373;77539.87972345452;426.4094229492114;439.9384086227931;440.7972332726982;441.16839757058176;441.28511810866604;9583.616655333988;9708.466034368177;9765.462899540593;9799.706008819747;9857.063578959987;35920.28159436744;36362.63637363698;36673.26653466969;36819.63180368269;37172.628273718;47769.28346074881;48974.75512622414;49847.252291214936;49934.250986235966;50269.49730502648;7217.891731624135;7625.580593067434;7683;7736.690532378641;8115.55364454937;10532.842007369742;11056.391898445663;11680.532778688757;11766.470508826953;12172.330521821385;10385.428801415994;10442.477876106317;10497.737556561147;10497.9475102624;10906.236563440483;5077.9238311424615;9130.497822619554;9208.12522810332;10188.490575471049;10781.460926953465;10462.424566648908;10503.842442363219;10519.158467322748;10605.575776968835;11111.44442777874;7546.584937828253;7624.709485002952;7794.103678076867;7860.213978602094;8119.959400202961;10127.392356458637;10150.441725705157;10316.43259620698;10632.627858025242;10725.249232553646 01:01:40 INFO - PROCESS | 10113 | |3;mootools.html;1307.398596645543;1338.4846833968925;1421.268046955818;1651.0671470619093;1675.6983742926268;6827.351401616845;7123;7129.073220481343;7135.571865688049;7138.179109402414;6063.272407311118;6182.381761823815;6207.037909124082;6229.190205273319;7011.859762804741;1818.709006558951;2026.1591439552567;2110.229766135365;2114.2388740053643;2136.4979229880964;2119.957600847982;2145.4850835799375;2151.5051538146236;2153.224839057938;2156.6010288096754;2090.644590419632;2100.527381339202;2109.219588752164;2113.968290475644;2114.6193685136745;1994.3219305436076;2009.357005758158;2096.15105882118;2101.2960658179527;2105.589410065038;2093.2359688713664;2115.8095771380495;2119.8198153157;2127.9787202127936;2130.371540395587;7065.858682826315;7130.964345178241;7137.750178743719;7138.393236574897;7138.928610713879;4338.110687309094;4469.195544801934;4475.172093162742;4477.7984990675495;4486.730796152241;2629.3426643339167;2820.1257610140924;2877.0649538899734;2885.1633026422314;2910.9708902911125;881.0836729800999;884.0982198157907;889.8798662180587;916.2669864108686;925.0749250749251;9594.808103837884;9606.99999999993;9616.90383096167;9617.086376794263;9622.470764107971;4022.8591999279884;4060.9187816244103;4173.520045194841;4210.536840947493;4221;8361.080281169066;8386.077531471534;8393.328533717287;8394.118617545191;8409.495430274203;4573.108243892476;4574.6340292776495;4575.24508456101;4576.81692732287;4580.358749775034;4066.3900414938;4081.5306239782212;4154.563770804022;4164.66682665386;4183.5398106208295;3145.748340132784;3274.6561611030497;3282.179455136216;3422.264213194175;3437.089171369589;1072.2494254022215;1083.9241253112207;1089.9618513351995;1091.4542728635681;1091.9890801092047;637.6556659403869;825.6243409248777;829.6349606173264;846.9915300847036;868.7393781865542;4784.234522476457;4836.347093142451;4864.416270047617;4951.678140920829;5194.454582268883;766.1342682768436;779.8401327727802;802.101646156297;820.8057276662441;822.1572887790063;3488.0930957951114;3549.964500355015;3582.426811710166;3611.5124458198334;3629.3467175908063;8105.554194519358;8721.694740684046;8729.694460693845;8756.781080472912;8781.648734050566;8610.655573777103;8686.435381700168;8691.174338437839;8691.652333906699;8693.565321734015;6553.475721942234;6657.46740260778;6718.462522998148;6721.831954201086;6740.258571557125;4922.606191504743;4932.062908047459;4945.950540494549;5145.893632868801;5196.558292545024;7356.521826081502;7482.850342993001;7516.436267279866;7565.394768418403;7656.540607563564;7481.177070522347;7576.128745194374;7593.126790418952;7598.392128629585;7605.315521603082;6220.129181914626;6353.269374021862;6356.110144579855;6376.713047912763;6382.5532212744665;6014.127951446928;6283.717232724447;6642.402183803288;6824.7952561423235;6895;6076.969615151896;6168.537359697951;6171.105189747551;6172.598781079216;6263.718132683949;6081.543884208791;6108.236470441195;6156.722947467285;6185.2886918003205;6345.079963405373;5599.132134519156;5603.859903502282;5641.379448260606;5646.322441307069;5659.292588426447;4335.631471324847;4338;4436.667249956202;4450.577195166454;4522.819087236474;4265.317549192115;4397.780110994501;4544.636429085731;4614.607758340579;4636.698614590041 01:01:40 INFO - PROCESS | 10113 | |4;prototype.html;346.84218680500373;348.39553374894564;350.48128769421254;356.3194298889122;361.3062919195145;4835.661503694739;4873.951260487394;4874.48817874123;4894.461609222983;4923.163062279412;4782.689125206859;4786.401699787527;4824.565789078983;4861.124997500448;4873.902521949568;3637.145270861352;3724.664780169784;3747.7938713370754;3821.7515861469055;3840.8079596020225;3842.1931394407206;3846.9038274043232;3862.38201887698;3868.1103346230384;3868.593797651248;3823.2162406706557;3833.5591406988133;3835.252125835463;3838.7888666123354;3842.884713458601;3663.19409729859;3711.721620878445;3754.9436758448646;3838.8272527736317;3853.094522787143;3462.549868517102;3465.203003309253;3476.600190978045;3477.2002439438816;3489.842957066938;4650.18621741194;4692.389989301369;4693.718376897397;4694.389729335198;4728.338032675429;4304.418903448057;4416.624586910117;4436.334549817521;4439.822407103712;4453.198424283628;5023.748812559394;5059.114654935372;5063.569486646394;5065.1642478990925;5078.46676099008;3813.951163430051;3815.8282877270312;3820.6561409473;3846.8653597123966;3852.9614703852885;5106.66806657566;5315.415304316522;5317.149256119041;5340.359156901197;5345.866353341159;3915.804209789499;3920.7843568604;3930.862419815293;3931.66580840626;3941.896269044672;3979.4826672532386;3981.3231750602467;3988.940165897514;3991.5210174779213;3997.2804895118575;4401.581849724271;4420.9336859947125;4436.0240747035605;4442.933355999663;4450.174139421426;4974.527419895104;5038.813145243935;5050.156692807099;5097.439281679012;5119.846404607868;1334.813126162338;1345.2332170662628;1352.8985326100583;1353.4518519999417;1358.7893876449166;895.8835351404276;925.2181906289175;949.1599934058409;960.8764630167408;964.3056998960737;4221.775685051301;4343.804528796211;4451.087527056946;4469.854469854488;4476.35092911526;5109.821156259513;5142.434332223453;5183.352080989876;5194.246834209094;5205.7397130143345;4437.4912529739395;4443.666724995638;4452.666050046259;4466.441694788152;4478.529754375743;2538.7968962482955;2665.506881226979;2678.370582913014;2683.0877501649143;2690.9058182963895;4723.669343145947;4738;4739.791353204911;4782.450018247877;4797;5002.52476014778;5233.947660523346;5240.9213861792105;5257.973710131501;5267.420583735786;4633.999999999933;4666.976665116653;4677.48547659764;4765.379770877918;4773.403324584427;5031.7735701894235;5051.191809310492;5064.5948324134715;5070.442251352274;5077.873053173553;4824.541668541483;4980.477049909852;4990.176620857663;5016.523430274118;5016.949830501649;4845.176320025534;4855.150348689036;4880.267959806058;4891.853244402673;4906.779194936165;3632.582253040934;3637.672609465161;3657.908552286214;3669.412893936957;3685.576158741779;5096.210087436453;5205.843824685266;5230.163173892159;5230.529252367305;5231.241469986754;5036.294918711456;5049;5062.265971434048;5074.5686616637995;5091.465396133352;5043.4956504349275;5053.090443720165;5057.342545469065;5065.670731402447;5088.262201980618;4821.734804585782;4990.47600002009;4996.77578993149;5009.674371165863;5017.8243761468175;4863.537963893425;4892.461829198714;4961.280614310833;5045.571126454292;5075.502726695559;4901.803927842846;4934.383202099738;4948.307236986897;4965.553100220997;4984.950150498448 01:01:40 INFO - PROCESS | 10113 | |5;yui.html;612.2561088277747;625.7309356976501;638.3903372279474;721.74378095776;741.7811745535066;12443.751124977507;13298;13348.065635405514;13360.398782054806;13422.798658020138;13118.34408279587;13257.005724570648;13270.203787772716;13305.334733263346;13313.201207927506;594.447164137352;610.700756629253;735.8417940142868;749.7151082588622;771.9112302085276;758.2455456820471;771.097815555801;771.2518856709012;771.8263390737095;772.189201338595;829.4608504472081;830.2486249943811;831.1024093978519;831.2892476932227;831.6174559702514;642.8489305013318;657.158836689034;798.932090772285;812.4800127918137;820.6389188756958;608.4432744039199;609.6555446172943;610.1427494370416;610.3438803286484;610.3530257926568;13398.933005334911;13406.061575689706;13421.0605257632;13430.462781488728;13443.462261509529;12231.204971676812;12505.124641275115;12749.808752868714;12774.872251277462;12837.743245135138;11735.4132293385;11974.940125299405;11994.760104797942;12138.15032947694;12270.079744019235;4021.557628660845;4025.798710064485;4068.9389659155136;4105.507339119325;4152.91694166115;63796;64152.3584764151;64208.67895660492;64310.78095161951;69269;9949;10032.498375081363;10044.497775111215;10343.896561034293;10379;19305;19604.901975490317;19934.601307974048;20149.597008059758;20162.798372016092;6650.800475985729;6692.464602831762;6699.263081061079;6853.17761868579;6882.8967565486555;3640.0899775056237;3655.7258205634685;3702.9444558331647;3749.250149970017;3793.6016718244737;2626.1727555819857;2649.9072532461273;2660.7472290132405;2673;2719.0619236363423;465.8462707306581;468.8499680102403;472.2984528496992;473.3042427631376;478.65975269245973;470.901110766736;491.7393781295919;556.6354038105047;575.8186171356009;581.4214856218006;7662;7947.4436789425345;7947.652576319282;8097.311728503026;8152.714654987047;451.559729263965;524.2477045439806;535.4458135829398;544.6024402186426;580.7880123754799;3640.2901434220603;3738.2149748553106;3826.196498735241;3844.500214972036;4019.8995025124605;61847.38152618506;62888.37111628916;66557.33442665511;66696.33303666998;66778.66610666916;55638.44361556332;57319;59281.70359148263;59839.401605984254;61486.38513614896;51002.489975100514;51754.48245517572;52441.47558524442;53082.73458632759;53472.197917032056;7605;7690.577018263825;7757.301842834172;7758.418118641237;7908.6045697713735;31097.37805243928;35006.82496587501;35804.82097589495;36044;36306.18469076483;44902.3264651037;46558.76720616511;50007.749961251415;50064.49935500744;51956;9774.12032917041;9802.509874506104;9964.900350996397;10060.496975151067;10515.474226288501;10896.346219226554;10899.727506812393;12396.194247373893;12664.620061398173;12716.809247861474;11974.700632484257;12309.26144431337;12514.329575246673;12935.159214651394;13005.869941300465;12133.21134126279;12308.446119924803;12724.236545807282;13161.407736651681;13279.601611951657;11474.2889085202;12323.50705971751;12551;12570.43433045497;12689.111762176928;10097.798044039226;10130.746731331481;10624.415657138623;11064.446777661246;11081.944590277319;9697.951510242687;10286.948565257126;10630.468476575985;10682.786344273227;10930.014372404843 01:01:40 INFO - PROCESS | 10113 | __end_tp_report 01:01:40 INFO - PROCESS | 10113 | __start_cc_report 01:01:40 INFO - PROCESS | 10113 | _x_x_mozilla_cycle_collect,1610 01:01:40 INFO - PROCESS | 10113 | __end_cc_report 01:01:40 INFO - PROCESS | 10113 | __startTimestamp1482224500489__endTimestamp 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | ------- Summary: start ------- 01:01:40 INFO - PROCESS | 10113 | Number of tests: 6 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#0] dojo.html Cycles:165 Average:4667.66 Median:4778.81 stddev:497.22 (10.4%) stddev-sans-first:471.16 01:01:40 INFO - PROCESS | 10113 | Values: 2585.7 2621.6 2632.1 2648.1 2661.4 4604.4 4680.7 4736.2 4740.6 4765.5 4664.3 4674.8 4696.5 4742.6 4767.4 4283.6 4303.5 4354.2 4355.5 4460.3 4307.3 4335.8 4444.1 4471.1 4519.5 4210.3 4251.4 4434.5 4480.1 4530.5 4264.8 4286.9 4287.5 4291.2 4299.5 4263.7 4264.2 4284.6 4290.6 4309.7 4689.2 4721.2 4730.1 4777.8 4778.8 5059.1 5059.3 5075.1 5077.8 5123.5 4941.8 4984.0 4988.5 5059.1 5106.0 4754.5 4774.4 4775.6 4822.7 4826.8 5176.4 5221.1 5225.5 5232.7 5277.3 4832.7 4870.9 5016.7 5018.7 5019.0 5005.7 5010.4 5049.4 5058.1 5131.3 5007.2 5033.3 5043.2 5044.5 5091.8 5008.5 5027.7 5040.7 5041.4 5086.2 4095.5 4121.3 4122.1 4180.1 4203.0 3698.2 3707.9 3733.0 3737.3 3745.2 4324.5 4333.9 4340.5 4355.8 4380.4 4939.2 4976.8 5085.8 5094.1 5094.7 4287.2 4346.0 4358.2 4363.7 4425.2 4578.2 4591.5 4598.3 4602.5 4610.1 4756.7 4759.1 4759.5 4764.8 4806.9 4921.7 4986.6 5059.9 5081.1 5101.8 4760.0 4761.3 4764.1 4795.6 4810.6 5014.6 5014.9 5015.4 5016.7 5050.2 4866.3 4909.1 5003.7 5020.1 5036.3 4922.2 4932.5 4934.1 4966.4 4982.7 4958.5 4971.0 4973.2 4978.3 4984.4 4677.1 4754.8 4829.6 4900.7 4936.5 4910.7 4970.9 4974.3 5011.9 5012.7 4689.3 4856.8 4859.9 4903.2 4903.9 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#1] ext.html Cycles:180 Average:42982.84 Median:3489.95 stddev:73511.57 (2106.4%) stddev-sans-first:73648.61 01:01:40 INFO - PROCESS | 10113 | Values: 510.0 541.9 544.3 551.5 559.4 24516.3 35324.6 37452.6 37535.0 41234.0 37392.0 37802.2 37813.0 37816.2 37828.6 7542.5 7722.6 7729.7 7733.7 7735.0 7273.9 7485.6 9351.3 9688.3 9692.0 9953.6 10020.6 10023.1 10026.1 10027.2 9852.6 9912.7 9924.8 9927.7 9931.6 7219.7 7428.4 9470.4 9777.1 9786.6 36033.6 36358.8 36431.0 36440.1 36478.3 2826.3 2870.2 2906.4 2928.5 3531.1 26883.3 27047.7 27154.6 27363.2 28017.6 3397.3 3460.7 3480.6 3499.3 3549.1 234604.0 235233.0 235654.0 236052.0 236957.0 40854.8 40963.6 41065.4 41099.2 41208.8 52525.0 52606.0 52634.9 52713.2 52806.7 13148.8 13325.1 13346.5 13351.9 13360.1 8981.1 9829.6 9849.8 9853.0 9855.5 13438.1 14449.9 14860.6 14996.3 15407.5 6032.5 6116.9 6129.2 6281.9 6379.7 750.7 787.6 924.1 942.0 944.0 25023.6 26585.2 26906.5 27003.5 27025.3 904.1 928.7 960.3 966.8 972.5 13383.4 14156.0 14334.1 14481.9 14483.5 317054.0 318787.0 319366.0 319528.0 320453.0 46715.8 46717.3 46755.8 46805.0 46908.0 1024.9 1121.3 1138.3 1140.1 1149.1 25199.7 26079.0 26484.0 26842.2 27077.0 40587.6 40671.8 40855.4 41090.4 41121.8 280803.0 281869.0 282091.0 282212.0 282651.0 29251.0 29910.4 30114.8 30415.2 30556.4 39225.0 39452.6 39609.2 40400.4 40668.0 33482.7 33888.0 33981.5 34449.5 34751.8 33616.8 33907.3 34238.7 34478.7 35288.1 33147.0 33957.5 34108.1 34692.5 34719.3 29129.9 31147.5 31331.8 31537.2 31620.7 23243.0 23398.6 23652.5 23702.4 23786.4 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#2] jquery.html Cycles:180 Average:20886.92 Median:48372.02 stddev:48570.22 (100.4%) stddev-sans-first:48682.00 01:01:40 INFO - PROCESS | 10113 | Values: 348.2 365.8 372.4 375.3 396.5 12320.1 15333.2 15628.0 15758.9 16356.0 15779.8 15931.1 16107.2 16230.8 16312.2 4912.8 4930.2 5091.4 5120.6 5137.7 3658.2 3863.6 5027.6 5082.5 5127.6 5682.2 5934.9 5943.4 6040.1 6041.0 5808.1 5897.1 5935.9 6027.1 6038.3 5230.4 5234.2 5235.9 5237.9 5238.9 19401.3 19814.6 19878.6 19913.2 19973.8 1840.5 1919.9 1945.7 1974.2 2023.6 12112.7 12948.1 13146.9 13531.2 13544.1 1704.2 1769.6 1817.7 1825.6 1844.8 62591.7 64879.0 65460.0 66692.7 67150.3 9250.4 9257.7 9401.2 9638.0 9805.6 13079.6 13084.9 13089.5 13106.7 13112.7 6873.5 7001.2 7002.6 7209.6 7215.0 6659.4 6703.3 6894.3 6936.5 6959.7 5924.3 6011.5 6023.4 6054.7 6180.6 1718.8 1735.5 1754.1 1767.5 1770.4 794.7 817.4 853.6 904.5 944.1 15752.1 16371.5 16694.6 16951.5 17724.3 862.7 864.6 866.9 877.6 937.5 5226.9 5373.8 9294.7 9936.2 10065.5 224438.0 225072.7 259345.0 347141.0 361337.0 63161.0 76313.6 76749.2 76963.6 77539.9 426.4 439.9 440.8 441.2 441.3 9583.6 9708.5 9765.5 9799.7 9857.1 35920.3 36362.6 36673.3 36819.6 37172.6 47769.3 48974.8 49847.3 49934.3 50269.5 7217.9 7625.6 7683.0 7736.7 8115.6 10532.8 11056.4 11680.5 11766.5 12172.3 10385.4 10442.5 10497.7 10497.9 10906.2 5077.9 9130.5 9208.1 10188.5 10781.5 10462.4 10503.8 10519.2 10605.6 11111.4 7546.6 7624.7 7794.1 7860.2 8120.0 10127.4 10150.4 10316.4 10632.6 10725.2 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#3] mootools.html Cycles:180 Average:4717.70 Median:5601.50 stddev:2506.10 (44.7%) stddev-sans-first:2500.02 01:01:40 INFO - PROCESS | 10113 | Values: 1307.4 1338.5 1421.3 1651.1 1675.7 6827.4 7123.0 7129.1 7135.6 7138.2 6063.3 6182.4 6207.0 6229.2 7011.9 1818.7 2026.2 2110.2 2114.2 2136.5 2120.0 2145.5 2151.5 2153.2 2156.6 2090.6 2100.5 2109.2 2114.0 2114.6 1994.3 2009.4 2096.2 2101.3 2105.6 2093.2 2115.8 2119.8 2128.0 2130.4 7065.9 7131.0 7137.8 7138.4 7138.9 4338.1 4469.2 4475.2 4477.8 4486.7 2629.3 2820.1 2877.1 2885.2 2911.0 881.1 884.1 889.9 916.3 925.1 9594.8 9607.0 9616.9 9617.1 9622.5 4022.9 4060.9 4173.5 4210.5 4221.0 8361.1 8386.1 8393.3 8394.1 8409.5 4573.1 4574.6 4575.2 4576.8 4580.4 4066.4 4081.5 4154.6 4164.7 4183.5 3145.7 3274.7 3282.2 3422.3 3437.1 1072.2 1083.9 1090.0 1091.5 1092.0 637.7 825.6 829.6 847.0 868.7 4784.2 4836.3 4864.4 4951.7 5194.5 766.1 779.8 802.1 820.8 822.2 3488.1 3550.0 3582.4 3611.5 3629.3 8105.6 8721.7 8729.7 8756.8 8781.6 8610.7 8686.4 8691.2 8691.7 8693.6 6553.5 6657.5 6718.5 6721.8 6740.3 4922.6 4932.1 4946.0 5145.9 5196.6 7356.5 7482.9 7516.4 7565.4 7656.5 7481.2 7576.1 7593.1 7598.4 7605.3 6220.1 6353.3 6356.1 6376.7 6382.6 6014.1 6283.7 6642.4 6824.8 6895.0 6077.0 6168.5 6171.1 6172.6 6263.7 6081.5 6108.2 6156.7 6185.3 6345.1 5599.1 5603.9 5641.4 5646.3 5659.3 4335.6 4338.0 4436.7 4450.6 4522.8 4265.3 4397.8 4544.6 4614.6 4636.7 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#4] prototype.html Cycles:180 Average:4216.64 Median:4752.59 stddev:1184.06 (24.9%) stddev-sans-first:1151.21 01:01:40 INFO - PROCESS | 10113 | Values: 346.8 348.4 350.5 356.3 361.3 4835.7 4874.0 4874.5 4894.5 4923.2 4782.7 4786.4 4824.6 4861.1 4873.9 3637.1 3724.7 3747.8 3821.8 3840.8 3842.2 3846.9 3862.4 3868.1 3868.6 3823.2 3833.6 3835.3 3838.8 3842.9 3663.2 3711.7 3754.9 3838.8 3853.1 3462.5 3465.2 3476.6 3477.2 3489.8 4650.2 4692.4 4693.7 4694.4 4728.3 4304.4 4416.6 4436.3 4439.8 4453.2 5023.7 5059.1 5063.6 5065.2 5078.5 3814.0 3815.8 3820.7 3846.9 3853.0 5106.7 5315.4 5317.1 5340.4 5345.9 3915.8 3920.8 3930.9 3931.7 3941.9 3979.5 3981.3 3988.9 3991.5 3997.3 4401.6 4420.9 4436.0 4442.9 4450.2 4974.5 5038.8 5050.2 5097.4 5119.8 1334.8 1345.2 1352.9 1353.5 1358.8 895.9 925.2 949.2 960.9 964.3 4221.8 4343.8 4451.1 4469.9 4476.4 5109.8 5142.4 5183.4 5194.2 5205.7 4437.5 4443.7 4452.7 4466.4 4478.5 2538.8 2665.5 2678.4 2683.1 2690.9 4723.7 4738.0 4739.8 4782.5 4797.0 5002.5 5233.9 5240.9 5258.0 5267.4 4634.0 4667.0 4677.5 4765.4 4773.4 5031.8 5051.2 5064.6 5070.4 5077.9 4824.5 4980.5 4990.2 5016.5 5016.9 4845.2 4855.2 4880.3 4891.9 4906.8 3632.6 3637.7 3657.9 3669.4 3685.6 5096.2 5205.8 5230.2 5230.5 5231.2 5036.3 5049.0 5062.3 5074.6 5091.5 5043.5 5053.1 5057.3 5065.7 5088.3 4821.7 4990.5 4996.8 5009.7 5017.8 4863.5 4892.5 4961.3 5045.6 5075.5 4901.8 4934.4 4948.3 4965.6 4985.0 01:01:40 INFO - PROCESS | 10113 | 01:01:40 INFO - PROCESS | 10113 | [#5] yui.html Cycles:180 Average:15064.86 Median:22676.94 stddev:18747.44 (82.7%) stddev-sans-first:18768.62 01:01:40 INFO - PROCESS | 10113 | Values: 612.3 625.7 638.4 721.7 741.8 12443.8 13298.0 13348.1 13360.4 13422.8 13118.3 13257.0 13270.2 13305.3 13313.2 594.4 610.7 735.8 749.7 771.9 758.2 771.1 771.3 771.8 772.2 829.5 830.2 831.1 831.3 831.6 642.8 657.2 798.9 812.5 820.6 608.4 609.7 610.1 610.3 610.4 13398.9 13406.1 13421.1 13430.5 13443.5 12231.2 12505.1 12749.8 12774.9 12837.7 11735.4 11974.9 11994.8 12138.2 12270.1 4021.6 4025.8 4068.9 4105.5 4152.9 63796.0 64152.4 64208.7 64310.8 69269.0 9949.0 10032.5 10044.5 10343.9 10379.0 19305.0 19604.9 19934.6 20149.6 20162.8 6650.8 6692.5 6699.3 6853.2 6882.9 3640.1 3655.7 3702.9 3749.3 3793.6 2626.2 2649.9 2660.7 2673.0 2719.1 465.8 468.8 472.3 473.3 478.7 470.9 491.7 556.6 575.8 581.4 7662.0 7947.4 7947.7 8097.3 8152.7 451.6 524.2 535.4 544.6 580.8 3640.3 3738.2 3826.2 3844.5 4019.9 61847.4 62888.4 66557.3 66696.3 66778.7 55638.4 57319.0 59281.7 59839.4 61486.4 51002.5 51754.5 52441.5 53082.7 53472.2 7605.0 7690.6 7757.3 7758.4 7908.6 31097.4 35006.8 35804.8 36044.0 36306.2 44902.3 46558.8 50007.7 50064.5 51956.0 9774.1 9802.5 9964.9 10060.5 10515.5 10896.3 10899.7 12396.2 12664.6 12716.8 11974.7 12309.3 12514.3 12935.2 13005.9 12133.2 12308.4 12724.2 13161.4 13279.6 11474.3 12323.5 12551.0 12570.4 12689.1 10097.8 10130.7 10624.4 11064.4 11081.9 9698.0 10286.9 10630.5 10682.8 10930.0 01:01:40 INFO - PROCESS | 10113 | -------- Summary: end -------- 01:01:40 INFO - PROCESS | 10113 | 01:01:41 INFO - TEST-INFO | 10113: exit 0 01:01:41 INFO - TEST-OK | dromaeo_css | took 1121865ms 01:01:41 INFO - TEST-START | kraken 01:01:41 INFO - operating with platform_type : linux_ 01:01:41 INFO - Initialising browser for kraken test... 01:01:41 INFO - TEST-INFO | started process 10414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps1RvSZ/profile http://localhost:42426/getInfo.html) 01:01:45 INFO - PROCESS | 10414 | __metrics Screen width/height:1600/1200 01:01:45 INFO - PROCESS | 10414 | colorDepth:24 01:01:45 INFO - PROCESS | 10414 | Browser inner width/height: 1024/697 01:01:45 INFO - PROCESS | 10414 | __metrics 01:01:45 INFO - PROCESS | 10414 | 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" 01:01:45 INFO - PROCESS | 10414 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:01:46 INFO - PROCESS | 10414 | console.error: PushService: 01:01:46 INFO - PROCESS | 10414 | stateChangeProcessEnqueue: Error transitioning state 01:01:46 INFO - PROCESS | 10414 | UnknownError 01:01:46 INFO - TEST-INFO | 10414: exit 0 01:01:46 INFO - Browser initialized. 01:01:46 INFO - Running cycle 1/1 for kraken test... 01:01:46 INFO - TEST-INFO | started process 10497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps1RvSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:59 INFO - PROCESS | 10497 | RSS: Main: 156061696 01:01:59 INFO - PROCESS | 10497 | 01:02:01 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42426/tests/kraken/driver.html?testName=audio-beat-detection) 01:02:02 INFO - PROCESS | 10497 | RSS: Main: 208855040 01:02:02 INFO - PROCESS | 10497 | 01:02:05 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42426/tests/kraken/driver.html?testName=audio-dft) 01:02:06 INFO - PROCESS | 10497 | RSS: Main: 187731968 01:02:06 INFO - PROCESS | 10497 | 01:02:09 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42426/tests/kraken/driver.html?testName=audio-fft) 01:02:09 INFO - PROCESS | 10497 | RSS: Main: 269422592 01:02:09 INFO - PROCESS | 10497 | 01:02:12 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42426/tests/kraken/driver.html?testName=audio-oscillator) 01:02:12 INFO - PROCESS | 10497 | RSS: Main: 180858880 01:02:12 INFO - PROCESS | 10497 | 01:02:14 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:02:15 INFO - PROCESS | 10497 | RSS: Main: 184418304 01:02:15 INFO - PROCESS | 10497 | 01:02:18 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42426/tests/kraken/driver.html?testName=imaging-darkroom) 01:02:19 INFO - PROCESS | 10497 | RSS: Main: 224346112 01:02:19 INFO - PROCESS | 10497 | 01:02:22 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42426/tests/kraken/driver.html?testName=imaging-desaturate) 01:02:23 INFO - PROCESS | 10497 | RSS: Main: 217665536 01:02:23 INFO - PROCESS | 10497 | 01:02:26 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42426/tests/kraken/driver.html?testName=json-parse-financial) 01:02:27 INFO - PROCESS | 10497 | RSS: Main: 219971584 01:02:27 INFO - PROCESS | 10497 | 01:02:28 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:02:29 INFO - PROCESS | 10497 | RSS: Main: 183349248 01:02:29 INFO - PROCESS | 10497 | 01:02:31 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:02:31 INFO - PROCESS | 10497 | RSS: Main: 191102976 01:02:31 INFO - PROCESS | 10497 | 01:02:34 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:02:34 INFO - PROCESS | 10497 | RSS: Main: 198451200 01:02:34 INFO - PROCESS | 10497 | 01:02:37 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:02:38 INFO - PROCESS | 10497 | RSS: Main: 208773120 01:02:38 INFO - PROCESS | 10497 | 01:02:41 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:02:42 INFO - PROCESS | 10497 | RSS: Main: 204877824 01:02:42 INFO - PROCESS | 10497 | 01:02:43 INFO - PROCESS | 10497 | Cycle 1(1): loaded http://localhost:42426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42426/tests/kraken/driver.html?testName=ai-astar) 01:02:44 INFO - PROCESS | 10497 | RSS: Main: 255102976 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | __start_tp_report 01:02:44 INFO - PROCESS | 10497 | _x_x_mozilla_page_load 01:02:44 INFO - PROCESS | 10497 | _x_x_mozilla_page_load_details 01:02:44 INFO - PROCESS | 10497 | |i|pagename|runs| 01:02:44 INFO - PROCESS | 10497 | |0;ai-astar;109;115;117;116;116;115;117;117;117;115 01:02:44 INFO - PROCESS | 10497 | |1;audio-beat-detection;162;127;124;160;131;127;124;129;155;124 01:02:44 INFO - PROCESS | 10497 | |2;audio-dft;161;161;161;161;161;162;162;162;161;161 01:02:44 INFO - PROCESS | 10497 | |3;audio-fft;76;76;76;114;77;76;77;78;92;78 01:02:44 INFO - PROCESS | 10497 | |4;audio-oscillator;84;86;124;86;85;85;109;85;85;108 01:02:44 INFO - PROCESS | 10497 | |5;imaging-gaussian-blur;127;127;127;127;127;127;127;127;127;127 01:02:44 INFO - PROCESS | 10497 | |6;imaging-darkroom;146;147;146;146;146;148;146;147;146;148 01:02:44 INFO - PROCESS | 10497 | |7;imaging-desaturate;96;96;96;96;96;95;95;96;95;96 01:02:44 INFO - PROCESS | 10497 | |8;json-parse-financial;67;63;64;63;66;64;75;67;67;65 01:02:44 INFO - PROCESS | 10497 | |9;json-stringify-tinderbox;68;67;66;66;67;66;70;66;66;66 01:02:44 INFO - PROCESS | 10497 | |10;stanford-crypto-aes;87;84;83;87;83;84;93;85;85;84 01:02:44 INFO - PROCESS | 10497 | |11;stanford-crypto-ccm;144;140;139;133;133;135;142;156;179;134 01:02:44 INFO - PROCESS | 10497 | |12;stanford-crypto-pbkdf2;193;181;184;190;180;182;179;185;179;177 01:02:44 INFO - PROCESS | 10497 | |13;stanford-crypto-sha256-iterative;70;69;68;68;67;68;67;68;68;68 01:02:44 INFO - PROCESS | 10497 | __end_tp_report 01:02:44 INFO - PROCESS | 10497 | __start_cc_report 01:02:44 INFO - PROCESS | 10497 | _x_x_mozilla_cycle_collect,1979 01:02:44 INFO - PROCESS | 10497 | __end_cc_report 01:02:44 INFO - PROCESS | 10497 | __startTimestamp1482224564033__endTimestamp 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | ------- Summary: start ------- 01:02:44 INFO - PROCESS | 10497 | Number of tests: 14 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:2.41 (2.1%) stddev-sans-first:0.93 01:02:44 INFO - PROCESS | 10497 | Values: 109.0 115.0 117.0 116.0 116.0 115.0 117.0 117.0 117.0 115.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:130.00 stddev:15.92 (12.2%) stddev-sans-first:13.90 01:02:44 INFO - PROCESS | 10497 | Values: 162.0 127.0 124.0 160.0 131.0 127.0 124.0 129.0 155.0 124.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:02:44 INFO - PROCESS | 10497 | Values: 161.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 161.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.25 (15.9%) stddev-sans-first:12.80 01:02:44 INFO - PROCESS | 10497 | Values: 76.0 76.0 76.0 114.0 77.0 76.0 77.0 78.0 92.0 78.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:85.00 stddev:14.42 (17.0%) stddev-sans-first:14.86 01:02:44 INFO - PROCESS | 10497 | Values: 84.0 86.0 124.0 86.0 85.0 85.0 109.0 85.0 85.0 108.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:02:44 INFO - PROCESS | 10497 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 01:02:44 INFO - PROCESS | 10497 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 147.0 146.0 148.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:02:44 INFO - PROCESS | 10497 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.50 stddev:3.51 (5.3%) stddev-sans-first:3.71 01:02:44 INFO - PROCESS | 10497 | Values: 67.0 63.0 64.0 63.0 66.0 64.0 75.0 67.0 67.0 65.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.32 01:02:44 INFO - PROCESS | 10497 | Values: 68.0 67.0 66.0 66.0 67.0 66.0 70.0 66.0 66.0 66.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:2.99 (3.5%) stddev-sans-first:3.12 01:02:44 INFO - PROCESS | 10497 | Values: 87.0 84.0 83.0 87.0 83.0 84.0 93.0 85.0 85.0 84.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:141.00 stddev:14.28 (10.1%) stddev-sans-first:15.14 01:02:44 INFO - PROCESS | 10497 | Values: 144.0 140.0 139.0 133.0 133.0 135.0 142.0 156.0 179.0 134.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:183.00 stddev:5.12 (2.8%) stddev-sans-first:3.95 01:02:44 INFO - PROCESS | 10497 | Values: 193.0 181.0 184.0 190.0 180.0 182.0 179.0 185.0 179.0 177.0 01:02:44 INFO - PROCESS | 10497 | 01:02:44 INFO - PROCESS | 10497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.60 01:02:44 INFO - PROCESS | 10497 | Values: 70.0 69.0 68.0 68.0 67.0 68.0 67.0 68.0 68.0 68.0 01:02:44 INFO - PROCESS | 10497 | -------- Summary: end -------- 01:02:44 INFO - PROCESS | 10497 | 01:02:45 INFO - TEST-INFO | 10497: exit 0 01:02:45 INFO - TEST-OK | kraken | took 63897ms 01:02:45 INFO - SUITE-END | took 1185s 01:02:45 INFO - Completed test suite (00:19:46) 01:02:45 INFO - javascript benchmark 01:02:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.7155712871586, 2621.619865119559, 2632.144553020268, 2648.0864101884854, 2661.361273294409, 4604.401427814388, 4680.672352935296, 4736.242201247801, 4740.620750339973, 4765.499622539631, 4664.300354946759, 4674.836380726675, 4696.530346965302, 4742.6205903527725, 4767.427908650958, 4283.635890949257, 4303.505096913848, 4354.194474022316, 4355.499117601469, 4460.286354183331, 4307.267764480031, 4335.783210839445, 4444.133393988173, 4471.105778844244, 4519.480259770119, 4210.263203939329, 4251.383549385322, 4434.4678638563255, 4480.059187570614, 4530.478994915594, 4264.808083636244, 4286.892827679302, 4287.485501739811, 4291.184674911757, 4299.484061912591, 4263.701540892139, 4264.23243816113, 4284.550122237182, 4290.592393722592, 4309.719868208588, 4689.155951928651, 4721.220998535237, 4730.101280756645, 4777.784999674988, 4778.80884764609, 5059.06407314648, 5059.2916991621205, 5075.137226671474, 5077.822276220315, 5123.538881500645, 4941.777620007108, 4983.950160498421, 4988.5260900214425, 5059.114654935372, 5106.004329155816, 4754.453237877619, 4774.355462012653, 4775.570198682135, 4822.71063736177, 4826.806927722922, 5176.352955880515, 5221.086309895829, 5225.529702326809, 5232.686038837682, 5277.261183434322, 4832.734199619054, 4870.9269360959615, 5016.724080175552, 5018.698878067327, 5018.974905125524, 5005.674631148963, 5010.3737032870895, 5049.394072711299, 5058.114829904752, 5131.2559678846355, 5007.198848184273, 5033.270175824485, 5043.167877300204, 5044.545990860766, 5091.821786237464, 5008.524190201925, 5027.723475208825, 5040.722760248222, 5041.369828771403, 5086.160783470686, 4095.4675892133832, 4121.278776214151, 4122.072533679898, 4180.143070670566, 4202.978985105116, 3698.2418604186078, 3707.870224542182, 3732.9626703733156, 3737.32728108943, 3745.194783121642, 4324.481062272547, 4333.891652708708, 4340.500842403101, 4355.803988820448, 4380.408644832907, 4939.185034469272, 4976.800927962913, 5085.847424577269, 5094.133997220481, 5094.719790411563, 4287.206866729665, 4346.043870348518, 4358.150160718693, 4363.650907927358, 4425.22558552252, 4578.153041687298, 4591.517890621437, 4598.333241680005, 4602.516735742699, 4610.10103029906, 4756.7145971241835, 4759.095771803346, 4759.4764575896625, 4764.833230836974, 4806.855794326176, 4921.655484116078, 4986.576141027908, 5059.873503162303, 5081.11080560893, 5101.821436249714, 4760.047990401864, 4761.333413322069, 4764.094821983812, 4795.568398844121, 4810.5670489656095, 5014.598832093497, 5014.874628134326, 5015.448300686994, 5016.673916195436, 5050.191969284897, 4866.270059491105, 4909.140900342354, 5003.674761140514, 5020.096382651158, 5036.320096787033, 4922.212446008622, 4932.53140951609, 4934.111859865258, 4966.428860681068, 4982.7259500727805, 4958.504149585013, 4970.975145124396, 4973.204287314013, 4978.327925730125, 4984.40187177541, 4677.064587082529, 4754.833580824655, 4829.589484893823, 4900.730459824744, 4936.481669424802, 4910.680805747615, 4970.9254361183885, 4974.32846565709, 5011.949880501148, 5012.724300163526, 4689.320048593003, 4856.78144483492, 4859.902801943871, 4903.215485522299, 4903.8528844134735], "value": 4635.48750136876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.9770510327035, 541.8536995011347, 544.2706772924281, 551.5394645471032, 559.3846768554588, 24516.264512064645, 35324.646753532455, 37452.62547374522, 37535.0, 41234.0, 37392.0, 37802.24395512088, 37813.0, 37816.24367512648, 37828.62171378286, 7542.4720269581285, 7722.575258360788, 7729.72945946892, 7733.7293194738195, 7735.0, 7273.927260727378, 7485.5508669480005, 9351.345405821596, 9688.321817472779, 9692.0, 9953.601855925754, 10020.59917603295, 10023.09792118709, 10026.09765121139, 10027.247956403298, 9852.556634951408, 9912.702618921372, 9924.801503969953, 9927.702168934944, 9931.553080111413, 7219.675114619855, 7428.3685886699695, 9470.38442501242, 9777.120059194707, 9786.608535658635, 36033.63966360329, 36358.8182059088, 36431.0, 36440.088997775005, 36478.270434591424, 2826.2651710555197, 2870.2250392393935, 2906.404187141652, 2928.531434970416, 3531.099569609759, 26883.32791680204, 27047.729522704718, 27154.5926811098, 27363.17910462689, 28017.57973630397, 3397.303552771676, 3460.7058400036026, 3480.5823301203764, 3499.317633061554, 3549.1304630365726, 234603.99999999828, 235233.0, 235654.0, 236052.0, 236957.0, 40854.79572602177, 40963.59036409598, 41065.38401923973, 41099.1780164395, 41208.793956030626, 52525.0, 52606.0, 52634.89428927046, 52713.2093018605, 52806.735966319924, 13148.802767958488, 13325.13386629866, 13346.46614135443, 13351.93324033393, 13360.06479546442, 8981.05698901619, 9829.606815727433, 9849.803003939882, 9853.0, 9855.507224638739, 13438.126521776054, 14449.855501445061, 14860.582066124853, 14996.325165367585, 15407.460738874086, 6032.487238584682, 6116.938830611637, 6129.172561704113, 6281.937180628135, 6379.681015949184, 750.6584504050644, 787.6219414680985, 924.1359329027381, 941.9858702119474, 943.9764005899907, 25023.62464563033, 26585.202443926326, 26906.461870762865, 27003.459930801666, 27025.324366890985, 904.1230006893303, 928.7492377058156, 960.2893858544627, 966.8163049020663, 972.4748635736764, 13383.397747101404, 14156.0, 14334.093096792676, 14481.92759036198, 14483.49307774244, 317054.0, 318787.0, 319366.0, 319528.0, 320453.0, 46715.76642116836, 46717.29924051142, 46755.76622116868, 46805.0, 46908.0, 1024.861643678094, 1121.287982131336, 1138.3056335635422, 1140.0765380042192, 1149.0749946293315, 25199.73202411792, 26079.0, 26484.02731660892, 26842.194734158005, 27077.0, 40587.594124059564, 40671.796641016605, 40855.38716919308, 41090.38364424596, 41121.794391027855, 280803.0, 281869.0, 282091.0, 282212.0, 282651.0, 29251.0, 29910.401791964476, 30114.84942575273, 30415.239619009702, 30556.388872221985, 39225.0, 39452.605473944895, 39609.2078158441, 40400.39399408952, 40668.0, 33482.66517334795, 33888.0, 33981.49027764635, 34449.48325775166, 34751.826240868635, 33616.83191584027, 33907.321853563284, 34238.657613423544, 34478.65521344754, 35288.11779705425, 33147.0, 33957.49063764095, 34108.14729631779, 34692.47961280633, 34719.305613888086, 29129.85435072811, 31147.532787008666, 31331.84334078315, 31537.21156971094, 31620.683793161774, 23243.0, 23398.64902026505, 23652.52694946126, 23702.407439814142, 23786.40533986664], "value": 16840.26446944053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.15398581447073, 365.7768761055754, 372.35210733324016, 375.27009965616867, 396.46477255704804, 12320.137590368679, 15333.23333833308, 15628.0, 15758.921205393957, 16356.0, 15779.842201577982, 15931.123788191644, 16107.194640267999, 16230.83769162311, 16312.184390780443, 4912.778924948368, 4930.186519224324, 5091.389033316007, 5120.590352771788, 5137.743112844361, 3658.176910195198, 3863.594322596129, 5027.572656324217, 5082.51716086973, 5127.589792816584, 5682.204491371212, 5934.940650593482, 5943.375945525722, 6040.0939859021055, 6040.96979515104, 5808.099744539603, 5897.085951677497, 5935.881282374328, 6027.126066720323, 6038.305594856603, 5230.372355317349, 5234.214867769827, 5235.947640523584, 5237.921431178497, 5238.869028274324, 19401.32095376669, 19814.603707925762, 19878.60242795136, 19913.203471861107, 19973.800261997338, 1840.530664680498, 1919.9040047997544, 1945.6886898096236, 1974.2103158736477, 2023.6155130525153, 12112.697182570506, 12948.093633445662, 13146.868531314756, 13531.188128712309, 13544.119632223874, 1704.207543492282, 1769.5841477252836, 1817.690992531273, 1825.607494388713, 1844.8155184481445, 62591.6870415645, 64879.0, 65460.0, 66692.66653666749, 67150.32849671441, 9250.352475326798, 9257.67598134062, 9401.153896149242, 9637.951810240904, 9805.55874985613, 13079.607611771662, 13084.934575327254, 13089.476420943247, 13106.737865242641, 13112.737745245042, 6873.450123990069, 7001.214690254054, 7002.579845209304, 7209.6034718091005, 7215.0, 6659.4006539411685, 6703.3296670332575, 6894.310568943166, 6936.514443988974, 6959.652017399211, 5924.297314178639, 6011.458968692751, 6023.397660234029, 6054.7275372607455, 6180.629162250189, 1718.7507811367282, 1735.5227312489167, 1754.1229385307347, 1767.478593814802, 1770.4157627982993, 794.66226853587, 817.3992115794886, 853.6286715278874, 904.4844438669895, 944.1031020530523, 15752.133632650315, 16371.508854734138, 16694.58263543421, 16951.49145525636, 17724.29102835898, 862.7498025572513, 864.6152462154407, 866.9046404895456, 877.591919757316, 937.5499760115183, 5226.895462090737, 5373.7581808818695, 9294.72115836526, 9936.205103591696, 10065.496725163712, 224438.0, 225072.7463626845, 259345.0, 347141.0, 361337.0, 63161.0, 76313.61843190748, 76749.23250767532, 76963.61518192373, 77539.87972345452, 426.4094229492114, 439.9384086227931, 440.7972332726982, 441.16839757058176, 441.28511810866604, 9583.616655333988, 9708.466034368177, 9765.462899540593, 9799.706008819747, 9857.063578959987, 35920.28159436744, 36362.63637363698, 36673.26653466969, 36819.63180368269, 37172.628273718, 47769.28346074881, 48974.75512622414, 49847.252291214936, 49934.250986235966, 50269.49730502648, 7217.891731624135, 7625.580593067434, 7683.0, 7736.690532378641, 8115.55364454937, 10532.842007369742, 11056.391898445663, 11680.532778688757, 11766.470508826953, 12172.330521821385, 10385.428801415994, 10442.477876106317, 10497.737556561147, 10497.9475102624, 10906.236563440483, 5077.9238311424615, 9130.497822619554, 9208.12522810332, 10188.490575471049, 10781.460926953465, 10462.424566648908, 10503.842442363219, 10519.158467322748, 10605.575776968835, 11111.44442777874, 7546.584937828253, 7624.709485002952, 7794.103678076867, 7860.213978602094, 8119.959400202961, 10127.392356458637, 10150.441725705157, 10316.43259620698, 10632.627858025242, 10725.249232553646], "value": 7851.898411794886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.398596645543, 1338.4846833968925, 1421.268046955818, 1651.0671470619093, 1675.6983742926268, 6827.351401616845, 7123.0, 7129.073220481343, 7135.571865688049, 7138.179109402414, 6063.272407311118, 6182.381761823815, 6207.037909124082, 6229.190205273319, 7011.859762804741, 1818.709006558951, 2026.1591439552567, 2110.229766135365, 2114.2388740053643, 2136.4979229880964, 2119.957600847982, 2145.4850835799375, 2151.5051538146236, 2153.224839057938, 2156.6010288096754, 2090.644590419632, 2100.527381339202, 2109.219588752164, 2113.968290475644, 2114.6193685136745, 1994.3219305436076, 2009.357005758158, 2096.15105882118, 2101.2960658179527, 2105.589410065038, 2093.2359688713664, 2115.8095771380495, 2119.8198153157, 2127.9787202127936, 2130.371540395587, 7065.858682826315, 7130.964345178241, 7137.750178743719, 7138.393236574897, 7138.928610713879, 4338.110687309094, 4469.195544801934, 4475.172093162742, 4477.7984990675495, 4486.730796152241, 2629.3426643339167, 2820.1257610140924, 2877.0649538899734, 2885.1633026422314, 2910.9708902911125, 881.0836729800999, 884.0982198157907, 889.8798662180587, 916.2669864108686, 925.0749250749251, 9594.808103837884, 9606.99999999993, 9616.90383096167, 9617.086376794263, 9622.470764107971, 4022.8591999279884, 4060.9187816244103, 4173.520045194841, 4210.536840947493, 4221.0, 8361.080281169066, 8386.077531471534, 8393.328533717287, 8394.118617545191, 8409.495430274203, 4573.108243892476, 4574.6340292776495, 4575.24508456101, 4576.81692732287, 4580.358749775034, 4066.3900414938, 4081.5306239782212, 4154.563770804022, 4164.66682665386, 4183.5398106208295, 3145.748340132784, 3274.6561611030497, 3282.179455136216, 3422.264213194175, 3437.089171369589, 1072.2494254022215, 1083.9241253112207, 1089.9618513351995, 1091.4542728635681, 1091.9890801092047, 637.6556659403869, 825.6243409248777, 829.6349606173264, 846.9915300847036, 868.7393781865542, 4784.234522476457, 4836.347093142451, 4864.416270047617, 4951.678140920829, 5194.454582268883, 766.1342682768436, 779.8401327727802, 802.101646156297, 820.8057276662441, 822.1572887790063, 3488.0930957951114, 3549.964500355015, 3582.426811710166, 3611.5124458198334, 3629.3467175908063, 8105.554194519358, 8721.694740684046, 8729.694460693845, 8756.781080472912, 8781.648734050566, 8610.655573777103, 8686.435381700168, 8691.174338437839, 8691.652333906699, 8693.565321734015, 6553.475721942234, 6657.46740260778, 6718.462522998148, 6721.831954201086, 6740.258571557125, 4922.606191504743, 4932.062908047459, 4945.950540494549, 5145.893632868801, 5196.558292545024, 7356.521826081502, 7482.850342993001, 7516.436267279866, 7565.394768418403, 7656.540607563564, 7481.177070522347, 7576.128745194374, 7593.126790418952, 7598.392128629585, 7605.315521603082, 6220.129181914626, 6353.269374021862, 6356.110144579855, 6376.713047912763, 6382.5532212744665, 6014.127951446928, 6283.717232724447, 6642.402183803288, 6824.7952561423235, 6895.0, 6076.969615151896, 6168.537359697951, 6171.105189747551, 6172.598781079216, 6263.718132683949, 6081.543884208791, 6108.236470441195, 6156.722947467285, 6185.2886918003205, 6345.079963405373, 5599.132134519156, 5603.859903502282, 5641.379448260606, 5646.322441307069, 5659.292588426447, 4335.631471324847, 4338.0, 4436.667249956202, 4450.577195166454, 4522.819087236474, 4265.317549192115, 4397.780110994501, 4544.636429085731, 4614.607758340579, 4636.698614590041], "value": 3866.0032433724514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.84218680500373, 348.39553374894564, 350.48128769421254, 356.3194298889122, 361.3062919195145, 4835.661503694739, 4873.951260487394, 4874.48817874123, 4894.461609222983, 4923.163062279412, 4782.689125206859, 4786.401699787527, 4824.565789078983, 4861.124997500448, 4873.902521949568, 3637.145270861352, 3724.664780169784, 3747.7938713370754, 3821.7515861469055, 3840.8079596020225, 3842.1931394407206, 3846.9038274043232, 3862.38201887698, 3868.1103346230384, 3868.593797651248, 3823.2162406706557, 3833.5591406988133, 3835.252125835463, 3838.7888666123354, 3842.884713458601, 3663.19409729859, 3711.721620878445, 3754.9436758448646, 3838.8272527736317, 3853.094522787143, 3462.549868517102, 3465.203003309253, 3476.600190978045, 3477.2002439438816, 3489.842957066938, 4650.18621741194, 4692.389989301369, 4693.718376897397, 4694.389729335198, 4728.338032675429, 4304.418903448057, 4416.624586910117, 4436.334549817521, 4439.822407103712, 4453.198424283628, 5023.748812559394, 5059.114654935372, 5063.569486646394, 5065.1642478990925, 5078.46676099008, 3813.951163430051, 3815.8282877270312, 3820.6561409473, 3846.8653597123966, 3852.9614703852885, 5106.66806657566, 5315.415304316522, 5317.149256119041, 5340.359156901197, 5345.866353341159, 3915.804209789499, 3920.7843568604, 3930.862419815293, 3931.66580840626, 3941.896269044672, 3979.4826672532386, 3981.3231750602467, 3988.940165897514, 3991.5210174779213, 3997.2804895118575, 4401.581849724271, 4420.9336859947125, 4436.0240747035605, 4442.933355999663, 4450.174139421426, 4974.527419895104, 5038.813145243935, 5050.156692807099, 5097.439281679012, 5119.846404607868, 1334.813126162338, 1345.2332170662628, 1352.8985326100583, 1353.4518519999417, 1358.7893876449166, 895.8835351404276, 925.2181906289175, 949.1599934058409, 960.8764630167408, 964.3056998960737, 4221.775685051301, 4343.804528796211, 4451.087527056946, 4469.854469854488, 4476.35092911526, 5109.821156259513, 5142.434332223453, 5183.352080989876, 5194.246834209094, 5205.7397130143345, 4437.4912529739395, 4443.666724995638, 4452.666050046259, 4466.441694788152, 4478.529754375743, 2538.7968962482955, 2665.506881226979, 2678.370582913014, 2683.0877501649143, 2690.9058182963895, 4723.669343145947, 4738.0, 4739.791353204911, 4782.450018247877, 4797.0, 5002.52476014778, 5233.947660523346, 5240.9213861792105, 5257.973710131501, 5267.420583735786, 4633.999999999933, 4666.976665116653, 4677.48547659764, 4765.379770877918, 4773.403324584427, 5031.7735701894235, 5051.191809310492, 5064.5948324134715, 5070.442251352274, 5077.873053173553, 4824.541668541483, 4980.477049909852, 4990.176620857663, 5016.523430274118, 5016.949830501649, 4845.176320025534, 4855.150348689036, 4880.267959806058, 4891.853244402673, 4906.779194936165, 3632.582253040934, 3637.672609465161, 3657.908552286214, 3669.412893936957, 3685.576158741779, 5096.210087436453, 5205.843824685266, 5230.163173892159, 5230.529252367305, 5231.241469986754, 5036.294918711456, 5049.0, 5062.265971434048, 5074.5686616637995, 5091.465396133352, 5043.4956504349275, 5053.090443720165, 5057.342545469065, 5065.670731402447, 5088.262201980618, 4821.734804585782, 4990.47600002009, 4996.77578993149, 5009.674371165863, 5017.8243761468175, 4863.537963893425, 4892.461829198714, 4961.280614310833, 5045.571126454292, 5075.502726695559, 4901.803927842846, 4934.383202099738, 4948.307236986897, 4965.553100220997, 4984.950150498448], "value": 3858.7638468270775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.2561088277747, 625.7309356976501, 638.3903372279474, 721.74378095776, 741.7811745535066, 12443.751124977507, 13298.0, 13348.065635405514, 13360.398782054806, 13422.798658020138, 13118.34408279587, 13257.005724570648, 13270.203787772716, 13305.334733263346, 13313.201207927506, 594.447164137352, 610.700756629253, 735.8417940142868, 749.7151082588622, 771.9112302085276, 758.2455456820471, 771.097815555801, 771.2518856709012, 771.8263390737095, 772.189201338595, 829.4608504472081, 830.2486249943811, 831.1024093978519, 831.2892476932227, 831.6174559702514, 642.8489305013318, 657.158836689034, 798.932090772285, 812.4800127918137, 820.6389188756958, 608.4432744039199, 609.6555446172943, 610.1427494370416, 610.3438803286484, 610.3530257926568, 13398.933005334911, 13406.061575689706, 13421.0605257632, 13430.462781488728, 13443.462261509529, 12231.204971676812, 12505.124641275115, 12749.808752868714, 12774.872251277462, 12837.743245135138, 11735.4132293385, 11974.940125299405, 11994.760104797942, 12138.15032947694, 12270.079744019235, 4021.557628660845, 4025.798710064485, 4068.9389659155136, 4105.507339119325, 4152.91694166115, 63796.0, 64152.3584764151, 64208.67895660492, 64310.78095161951, 69269.0, 9949.0, 10032.498375081363, 10044.497775111215, 10343.896561034293, 10379.0, 19305.0, 19604.901975490317, 19934.601307974048, 20149.597008059758, 20162.798372016092, 6650.800475985729, 6692.464602831762, 6699.263081061079, 6853.17761868579, 6882.8967565486555, 3640.0899775056237, 3655.7258205634685, 3702.9444558331647, 3749.250149970017, 3793.6016718244737, 2626.1727555819857, 2649.9072532461273, 2660.7472290132405, 2673.0, 2719.0619236363423, 465.8462707306581, 468.8499680102403, 472.2984528496992, 473.3042427631376, 478.65975269245973, 470.901110766736, 491.7393781295919, 556.6354038105047, 575.8186171356009, 581.4214856218006, 7662.0, 7947.4436789425345, 7947.652576319282, 8097.311728503026, 8152.714654987047, 451.559729263965, 524.2477045439806, 535.4458135829398, 544.6024402186426, 580.7880123754799, 3640.2901434220603, 3738.2149748553106, 3826.196498735241, 3844.500214972036, 4019.8995025124605, 61847.38152618506, 62888.37111628916, 66557.33442665511, 66696.33303666998, 66778.66610666916, 55638.44361556332, 57319.0, 59281.70359148263, 59839.401605984254, 61486.38513614896, 51002.489975100514, 51754.48245517572, 52441.47558524442, 53082.73458632759, 53472.197917032056, 7605.0, 7690.577018263825, 7757.301842834172, 7758.418118641237, 7908.6045697713735, 31097.37805243928, 35006.82496587501, 35804.82097589495, 36044.0, 36306.18469076483, 44902.3264651037, 46558.76720616511, 50007.749961251415, 50064.49935500744, 51956.0, 9774.12032917041, 9802.509874506104, 9964.900350996397, 10060.496975151067, 10515.474226288501, 10896.346219226554, 10899.727506812393, 12396.194247373893, 12664.620061398173, 12716.809247861474, 11974.700632484257, 12309.26144431337, 12514.329575246673, 12935.159214651394, 13005.869941300465, 12133.21134126279, 12308.446119924803, 12724.236545807282, 13161.407736651681, 13279.601611951657, 11474.2889085202, 12323.50705971751, 12551.0, 12570.43433045497, 12689.111762176928, 10097.798044039226, 10130.746731331481, 10624.415657138623, 11064.446777661246, 11081.944590277319, 9697.951510242687, 10286.948565257126, 10630.468476575985, 10682.786344273227, 10930.014372404843], "value": 6260.469370420575, "unit": "score"}], "name": "dromaeo_css", "value": 6208.179522635077, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 117.0, 116.0, 116.0, 115.0, 117.0, 117.0, 117.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 127.0, 124.0, 160.0, 131.0, 127.0, 124.0, 129.0, 155.0, 124.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 114.0, 77.0, 76.0, 77.0, 78.0, 92.0, 78.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 124.0, 86.0, 85.0, 85.0, 109.0, 85.0, 85.0, 108.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 63.0, 66.0, 64.0, 75.0, 67.0, 67.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 66.0, 67.0, 66.0, 70.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 87.0, 83.0, 84.0, 93.0, 85.0, 85.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 139.0, 133.0, 133.0, 135.0, 142.0, 156.0, 179.0, 134.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 181.0, 184.0, 190.0, 180.0, 182.0, 179.0, 185.0, 179.0, 177.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1571.0, "alertThreshold": 2.0}]} 01:02:45 INFO - Return code: 0 01:02:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:02:45 INFO - # TBPL SUCCESS # 01:02:45 INFO - Running post-action listener: _resource_record_post_action 01:02:45 INFO - [mozharness: 2016-12-20 09:02:45.824146Z] Finished run-tests step (success) 01:02:45 INFO - Running post-run listener: _resource_record_post_run 01:02:45 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 381452288; Read time: 12; Write time: 298384 01:02:45 INFO - TinderboxPrint: CPU usage
13.1% 01:02:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:02:45 INFO - TinderboxPrint: I/O write bytes / time
381,452,288 / 298,384 01:02:45 INFO - TinderboxPrint: CPU idle
8,334.4 (86.9%) 01:02:45 INFO - TinderboxPrint: CPU user
1,213.7 (12.6%) 01:02:45 INFO - TinderboxPrint: Swap in / out
0 / 0 01:02:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99704832; Read time: 0; Write time: 91320 01:02:45 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 281747456; Read time: 0; Write time: 207064 01:02:46 INFO - Running post-run listener: _upload_blobber_files 01:02:46 INFO - Blob upload gear active. 01:02:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:02:46 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 01:02:46 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'] 01:02:46 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 01:02:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:02:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:02:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:02:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:47 INFO - (blobuploader) - INFO - Done attempting. 01:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:02:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:48 INFO - (blobuploader) - INFO - Done attempting. 01:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:51 INFO - (blobuploader) - INFO - Done attempting. 01:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:02:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:52 INFO - (blobuploader) - INFO - Done attempting. 01:02:52 INFO - (blobuploader) - INFO - Iteration through files over. 01:02:52 INFO - Return code: 0 01:02:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:02:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:02:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9caa2fdbf56691d8756936098b13de00faca5b50b0aba9e6df7e16154e30de7daea2b4cc3897728f2a46309134f58a49c477aa0b7aa076e72b84ce62dfae84c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/11071953da7f1a704ec78025120b98fb3391ff9771ee4818c947630735093ef28bdec1358e754cedc4aa987b87571133f9e2b68bd0f047e4f0924fe6a11fd8d4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3d90fab700434ef0abcbb8e898381c7f39ad781a6d3fa3b9054c36819fb238c522e50a3663e2633446a80567f25eefad177d411476429fa129fbf8005fbec6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/98d5c744525af0bf2a6772d495fb9722e00cac91e1b76080f3c038d3d3a16b4624f6d4a355ddd76c53631f18776cdccb06b885d7bf0a0a0fde58d1e7b5607b56"} 01:02:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:02:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:02:52 INFO - Contents: 01:02:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9caa2fdbf56691d8756936098b13de00faca5b50b0aba9e6df7e16154e30de7daea2b4cc3897728f2a46309134f58a49c477aa0b7aa076e72b84ce62dfae84c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/11071953da7f1a704ec78025120b98fb3391ff9771ee4818c947630735093ef28bdec1358e754cedc4aa987b87571133f9e2b68bd0f047e4f0924fe6a11fd8d4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3d90fab700434ef0abcbb8e898381c7f39ad781a6d3fa3b9054c36819fb238c522e50a3663e2633446a80567f25eefad177d411476429fa129fbf8005fbec6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/98d5c744525af0bf2a6772d495fb9722e00cac91e1b76080f3c038d3d3a16b4624f6d4a355ddd76c53631f18776cdccb06b885d7bf0a0a0fde58d1e7b5607b56"} 01:02:52 INFO - Running post-run listener: copy_logs_to_upload_dir 01:02:52 INFO - Copying logs to upload dir... 01:02:52 INFO - mkdir: /builds/slave/test/build/upload/logs 01:02:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.651219 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-20 01:02:52.249039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 01:02:52.252422) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9caa2fdbf56691d8756936098b13de00faca5b50b0aba9e6df7e16154e30de7daea2b4cc3897728f2a46309134f58a49c477aa0b7aa076e72b84ce62dfae84c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/11071953da7f1a704ec78025120b98fb3391ff9771ee4818c947630735093ef28bdec1358e754cedc4aa987b87571133f9e2b68bd0f047e4f0924fe6a11fd8d4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3d90fab700434ef0abcbb8e898381c7f39ad781a6d3fa3b9054c36819fb238c522e50a3663e2633446a80567f25eefad177d411476429fa129fbf8005fbec6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/98d5c744525af0bf2a6772d495fb9722e00cac91e1b76080f3c038d3d3a16b4624f6d4a355ddd76c53631f18776cdccb06b885d7bf0a0a0fde58d1e7b5607b56"} build_url:https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/daOLx6xsQV6PJ_WaquG5kw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9caa2fdbf56691d8756936098b13de00faca5b50b0aba9e6df7e16154e30de7daea2b4cc3897728f2a46309134f58a49c477aa0b7aa076e72b84ce62dfae84c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/11071953da7f1a704ec78025120b98fb3391ff9771ee4818c947630735093ef28bdec1358e754cedc4aa987b87571133f9e2b68bd0f047e4f0924fe6a11fd8d4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3d90fab700434ef0abcbb8e898381c7f39ad781a6d3fa3b9054c36819fb238c522e50a3663e2633446a80567f25eefad177d411476429fa129fbf8005fbec6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/98d5c744525af0bf2a6772d495fb9722e00cac91e1b76080f3c038d3d3a16b4624f6d4a355ddd76c53631f18776cdccb06b885d7bf0a0a0fde58d1e7b5607b56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 01:02:52.277517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 01:02:52.277916) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482220339.931099-887021975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 01:02:52.362758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 01:02:52.363097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 01:02:52.363408) ========= ========= Total master_lag: 0.18 =========