builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1477117455.33 results: success (0) buildid: 20161021204522 builduid: 85e3120657b947b89cc91a79909de0a4 revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.332904) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.333339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.333627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.363387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.363656) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 23:24:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.7M=0s 2016-10-21 23:24:15 (24.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.493743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.497109) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.546301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:15.546623) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --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=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 23:24:15,796 truncating revision to first 12 chars 2016-10-21 23:24:15,796 Setting DEBUG logging. 2016-10-21 23:24:15,797 attempt 1/10 2016-10-21 23:24:15,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96ca0ecdcfa7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 23:24:16,101 unpacking tar archive at: mozilla-aurora-96ca0ecdcfa7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:16.242052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:16.242333) ========= script_repo_revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:16.242774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:16.246223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 23:24:16.261945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-10-21 23:24:16.262256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:16 INFO - MultiFileLogger online at 20161021 23:24:16 in /builds/slave/test 23:24:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:24:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:16 INFO - {'append_to_log': False, 23:24:16 INFO - 'base_work_dir': '/builds/slave/test', 23:24:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:24:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:16 INFO - 'branch': 'Mozilla-Aurora', 23:24:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:16 INFO - 'config_files': ('talos/linux_config.py',), 23:24:16 INFO - 'default_actions': ('clobber', 23:24:16 INFO - 'read-buildbot-config', 23:24:16 INFO - 'download-and-extract', 23:24:16 INFO - 'populate-webroot', 23:24:16 INFO - 'create-virtualenv', 23:24:16 INFO - 'install', 23:24:16 INFO - 'run-tests'), 23:24:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:16 INFO - 'download_minidump_stackwalk': True, 23:24:16 INFO - 'download_symbols': 'ondemand', 23:24:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:16 INFO - 'installer_path': 'installer.exe', 23:24:16 INFO - 'log_level': 'info', 23:24:16 INFO - 'log_name': 'talos', 23:24:16 INFO - 'log_to_console': True, 23:24:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:16 INFO - 'opt_config_files': (), 23:24:16 INFO - 'pip_index': False, 23:24:16 INFO - 'sps_profile': False, 23:24:16 INFO - 'sps_profile_interval': 0, 23:24:16 INFO - 'suite': 'dromaeojs', 23:24:16 INFO - 'system_bits': '32', 23:24:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:16 INFO - 'title': 'talos-linux64-ix-014', 23:24:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:16 INFO - 'use_talos_json': True, 23:24:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:16 INFO - 'work_dir': 'build'} 23:24:16 INFO - [mozharness: 2016-10-22 06:24:16.604891Z] Running clobber step. 23:24:16 INFO - Running pre-action listener: _resource_record_pre_action 23:24:16 INFO - Running main action method: clobber 23:24:16 INFO - rmtree: /builds/slave/test/build 23:24:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:17 INFO - Running post-action listener: _resource_record_post_action 23:24:17 INFO - [mozharness: 2016-10-22 06:24:17.067621Z] Finished clobber step (success) 23:24:17 INFO - [mozharness: 2016-10-22 06:24:17.067723Z] Running read-buildbot-config step. 23:24:17 INFO - Running pre-action listener: _resource_record_pre_action 23:24:17 INFO - Running main action method: read_buildbot_config 23:24:17 INFO - Using buildbot properties: 23:24:17 INFO - { 23:24:17 INFO - "project": "", 23:24:17 INFO - "product": "firefox", 23:24:17 INFO - "script_repo_revision": "production", 23:24:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:24:17 INFO - "repository": "", 23:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:24:17 INFO - "buildid": "20161021204522", 23:24:17 INFO - "pgo_build": "True", 23:24:17 INFO - "basedir": "/builds/slave/test", 23:24:17 INFO - "buildnumber": 584, 23:24:17 INFO - "slavename": "talos-linux64-ix-014", 23:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:24:17 INFO - "platform": "ubuntu64_hw", 23:24:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:24:17 INFO - "branch": "mozilla-aurora", 23:24:17 INFO - "repo_path": "releases/mozilla-aurora", 23:24:17 INFO - "revision": "96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79", 23:24:17 INFO - "stage_platform": "linux64-pgo", 23:24:17 INFO - "builduid": "85e3120657b947b89cc91a79909de0a4", 23:24:17 INFO - "slavebuilddir": "test" 23:24:17 INFO - } 23:24:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 23:24:17 INFO - Running post-action listener: _resource_record_post_action 23:24:17 INFO - [mozharness: 2016-10-22 06:24:17.070190Z] Finished read-buildbot-config step (success) 23:24:17 INFO - [mozharness: 2016-10-22 06:24:17.070279Z] Running download-and-extract step. 23:24:17 INFO - Running pre-action listener: _resource_record_pre_action 23:24:17 INFO - Running main action method: download_and_extract 23:24:17 INFO - mkdir: /builds/slave/test/build/tests 23:24: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')]} 23:24:17 INFO - trying https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - Downloading https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:24:17 INFO - Downloaded 1361 bytes. 23:24:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - Using the following test package requirements: 23:24:17 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 23:24:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:24:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'jsshell-linux-x86_64.zip'], 23:24:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 23:24:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:24:17 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:24:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 23:24:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 23:24:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:24:18 INFO - Expected file size: 21907898 23:24:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:24:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 23:24:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:22 INFO - Fetch https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:24:23 INFO - Expected file size: 21907898 23:24:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 23:24:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:24:27 INFO - Fetch https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 23:24:28 INFO - Expected file size: 14414081 23:24: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')]} 23:24:28 INFO - trying https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 23:24:28 INFO - Downloading https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 23:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:24:29 INFO - Downloaded 63999648 bytes. 23:24:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 23:24:29 INFO - mkdir: /builds/slave/test/properties 23:24:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:29 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:29 INFO - Contents: 23:24:29 INFO - build_url:https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 23:24:30 INFO - Running post-action listener: _resource_record_post_action 23:24:30 INFO - Running post-action listener: set_extra_try_arguments 23:24:30 INFO - [mozharness: 2016-10-22 06:24:30.595482Z] Finished download-and-extract step (success) 23:24:30 INFO - [mozharness: 2016-10-22 06:24:30.595788Z] Running populate-webroot step. 23:24:30 INFO - Running pre-action listener: _resource_record_pre_action 23:24:30 INFO - Running main action method: populate_webroot 23:24:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:30 INFO - '--tppagecycles', 23:24:30 INFO - '7'], 23:24:30 INFO - 'tests': ['tsvgm']}}, 23:24:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['damp', 'tps']}, 23:24:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'tests': ['damp', 'tps']}, 23:24:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['dromaeo_dom']}, 23:24:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['basic_compositor_video']}, 23:24:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['a11yr', 23:24:30 INFO - 'ts_paint', 23:24:30 INFO - 'tpaint', 23:24:30 INFO - 'sessionrestore', 23:24:30 INFO - 'sessionrestore_no_auto_restore', 23:24:30 INFO - 'tabpaint']}, 23:24:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['tsvgx', 23:24:30 INFO - 'tsvgr_opacity', 23:24:30 INFO - 'tart', 23:24:30 INFO - 'tscrollx', 23:24:30 INFO - 'cart']}, 23:24:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:30 INFO - 'tsvgr_opacity', 23:24:30 INFO - 'tart', 23:24:30 INFO - 'tscrollx', 23:24:30 INFO - 'cart']}, 23:24:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'talos_options': ['--disable-e10s'], 23:24:30 INFO - 'tests': ['tp5o']}, 23:24:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'tests': ['tp5o']}, 23:24:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'talos_options': ['--disable-e10s', 23:24:30 INFO - '--xperf_path', 23:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:30 INFO - 'tests': ['tp5n']}, 23:24:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:30 INFO - 'talos_options': ['--xperf_path', 23:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:30 INFO - 'tests': ['tp5n']}}, 23:24:30 INFO - 'talos.zip': {'path': '', 23:24:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:30 INFO - Running post-action listener: _resource_record_post_action 23:24:30 INFO - [mozharness: 2016-10-22 06:24:30.618041Z] Finished populate-webroot step (success) 23:24:30 INFO - [mozharness: 2016-10-22 06:24:30.618135Z] Running create-virtualenv step. 23:24:30 INFO - Running pre-action listener: _resource_record_pre_action 23:24:30 INFO - Running main action method: create_virtualenv 23:24:30 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:30 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 23:24:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:30 INFO - Using real prefix '/usr' 23:24:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:31 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:33 INFO - Installing pip.................done. 23:24:33 INFO - Return code: 0 23:24:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:33 INFO - Using env: {'DISPLAY': ':0', 23:24:33 INFO - 'HOME': '/home/cltbld', 23:24:33 INFO - 'LANG': 'en_US.UTF-8', 23:24:33 INFO - 'LANGUAGE': 'en_US:en', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MAIL': '/var/mail/cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SHLVL': '1', 23:24:33 INFO - 'TERM': 'linux', 23:24:33 INFO - 'TMOUT': '86400', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - '_': '/tools/buildbot/bin/python'} 23:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:33 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 23:24:33 INFO - Cleaning up... 23:24:33 INFO - Return code: 0 23:24:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:33 INFO - Using env: {'DISPLAY': ':0', 23:24:33 INFO - 'HOME': '/home/cltbld', 23:24:33 INFO - 'LANG': 'en_US.UTF-8', 23:24:33 INFO - 'LANGUAGE': 'en_US:en', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MAIL': '/var/mail/cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SHLVL': '1', 23:24:33 INFO - 'TERM': 'linux', 23:24:33 INFO - 'TMOUT': '86400', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - '_': '/tools/buildbot/bin/python'} 23:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:33 INFO - Downloading/unpacking psutil>=3.1.1 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:35 INFO - Installing collected packages: psutil 23:24:35 INFO - Running setup.py install for psutil 23:24:35 INFO - building 'psutil._psutil_linux' extension 23:24:35 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 23:24:35 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 23:24:35 INFO - building 'psutil._psutil_posix' extension 23:24:35 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 23:24:36 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 23:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:36 INFO - Successfully installed psutil 23:24:36 INFO - Cleaning up... 23:24:36 INFO - Return code: 0 23:24:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:36 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:36 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 23:24:36 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 23:24:36 INFO - Using env: {'DISPLAY': ':0', 23:24:36 INFO - 'HOME': '/home/cltbld', 23:24:36 INFO - 'LANG': 'en_US.UTF-8', 23:24:36 INFO - 'LANGUAGE': 'en_US:en', 23:24:36 INFO - 'LOGNAME': 'cltbld', 23:24:36 INFO - 'MAIL': '/var/mail/cltbld', 23:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:36 INFO - 'MOZ_NO_REMOTE': '1', 23:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:36 INFO - 'NO_EM_RESTART': '1', 23:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:36 INFO - 'PWD': '/builds/slave/test', 23:24:36 INFO - 'SHELL': '/bin/bash', 23:24:36 INFO - 'SHLVL': '1', 23:24:36 INFO - 'TERM': 'linux', 23:24:36 INFO - 'TMOUT': '86400', 23:24:36 INFO - 'USER': 'cltbld', 23:24:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:36 INFO - '_': '/tools/buildbot/bin/python'} 23:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24:36 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 23:24:36 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 23:24:36 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 23:24:36 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 23:24:36 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 23:24:36 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 23:24:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:38 INFO - Installing collected packages: mozsystemmonitor 23:24:38 INFO - Running setup.py install for mozsystemmonitor 23:24:38 INFO - Successfully installed mozsystemmonitor 23:24:38 INFO - Cleaning up... 23:24:38 INFO - Return code: 0 23:24:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:38 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:38 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 23:24:38 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 23:24:38 INFO - Using env: {'DISPLAY': ':0', 23:24:38 INFO - 'HOME': '/home/cltbld', 23:24:38 INFO - 'LANG': 'en_US.UTF-8', 23:24:38 INFO - 'LANGUAGE': 'en_US:en', 23:24:38 INFO - 'LOGNAME': 'cltbld', 23:24:38 INFO - 'MAIL': '/var/mail/cltbld', 23:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:38 INFO - 'MOZ_NO_REMOTE': '1', 23:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:38 INFO - 'NO_EM_RESTART': '1', 23:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:38 INFO - 'PWD': '/builds/slave/test', 23:24:38 INFO - 'SHELL': '/bin/bash', 23:24:38 INFO - 'SHLVL': '1', 23:24:38 INFO - 'TERM': 'linux', 23:24:38 INFO - 'TMOUT': '86400', 23:24:38 INFO - 'USER': 'cltbld', 23:24:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:38 INFO - '_': '/tools/buildbot/bin/python'} 23:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:38 INFO - Downloading/unpacking jsonschema==2.5.1 23:24:38 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 23:24:38 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 23:24:38 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 23:24:38 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 23:24:38 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 23:24:38 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 23:24:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:24:40 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 23:24:40 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 23:24:40 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 23:24:40 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 23:24:40 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 23:24:40 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 23:24:40 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:40 INFO - warning: no files found matching '*.txt' 23:24:40 INFO - no previously-included directories found matching 'build' 23:24:40 INFO - no previously-included directories found matching 'dist' 23:24:40 INFO - no previously-included directories found matching '.git*' 23:24:40 INFO - Installing collected packages: jsonschema, functools32 23:24:40 INFO - Running setup.py install for functools32 23:24:41 INFO - warning: no files found matching '*.txt' 23:24:41 INFO - no previously-included directories found matching 'build' 23:24:41 INFO - no previously-included directories found matching 'dist' 23:24:41 INFO - no previously-included directories found matching '.git*' 23:24:41 INFO - Successfully installed jsonschema functools32 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:24:41 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')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:41 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 23:24:41 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 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:41 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')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:41 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 23:24:41 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 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:41 INFO - Downloading/unpacking blobuploader==1.2.4 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:43 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:43 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 23:24:44 INFO - Downloading docopt-0.6.1.tar.gz 23:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:44 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:44 INFO - Running setup.py install for blobuploader 23:24:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:44 INFO - Running setup.py install for requests 23:24:44 INFO - Running setup.py install for docopt 23:24:44 INFO - Successfully installed blobuploader requests docopt 23:24:44 INFO - Cleaning up... 23:24:44 INFO - Return code: 0 23:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:44 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')]} 23:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:44 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')]} 23:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:44 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:44 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 23:24:44 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 23:24:44 INFO - Using env: {'DISPLAY': ':0', 23:24:44 INFO - 'HOME': '/home/cltbld', 23:24:44 INFO - 'LANG': 'en_US.UTF-8', 23:24:44 INFO - 'LANGUAGE': 'en_US:en', 23:24:44 INFO - 'LOGNAME': 'cltbld', 23:24:44 INFO - 'MAIL': '/var/mail/cltbld', 23:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:44 INFO - 'MOZ_NO_REMOTE': '1', 23:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:44 INFO - 'NO_EM_RESTART': '1', 23:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:44 INFO - 'PWD': '/builds/slave/test', 23:24:44 INFO - 'SHELL': '/bin/bash', 23:24:44 INFO - 'SHLVL': '1', 23:24:44 INFO - 'TERM': 'linux', 23:24:44 INFO - 'TMOUT': '86400', 23:24:44 INFO - 'USER': 'cltbld', 23:24:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:44 INFO - '_': '/tools/buildbot/bin/python'} 23:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:45 INFO - Running setup.py (path:/tmp/pip-FQvQVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:45 INFO - Running setup.py (path:/tmp/pip-VEcTQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:45 INFO - Running setup.py (path:/tmp/pip-B0WNrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:45 INFO - Running setup.py (path:/tmp/pip-rsZKKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:45 INFO - Running setup.py (path:/tmp/pip-JXJKjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:45 INFO - Running setup.py (path:/tmp/pip-RIl4eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:45 INFO - Running setup.py (path:/tmp/pip-7UZNoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:45 INFO - Running setup.py (path:/tmp/pip-wgFiVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:45 INFO - Running setup.py (path:/tmp/pip-6yIjXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:45 INFO - Running setup.py (path:/tmp/pip-zs4Z84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:45 INFO - Running setup.py (path:/tmp/pip-_FOE5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:45 INFO - Running setup.py (path:/tmp/pip-RjpZnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:45 INFO - Running setup.py (path:/tmp/pip-pXm40A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:46 INFO - Running setup.py (path:/tmp/pip-5cw39y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:46 INFO - Running setup.py (path:/tmp/pip-AnhWIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:46 INFO - Running setup.py (path:/tmp/pip-0Sx46C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:46 INFO - Running setup.py (path:/tmp/pip-Hh_MM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:46 INFO - Running setup.py install for manifestparser 23:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozcrash 23:24:46 INFO - Running setup.py install for mozdebug 23:24:46 INFO - Running setup.py install for mozdevice 23:24:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozfile 23:24:46 INFO - Running setup.py install for mozhttpd 23:24:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozinfo 23:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozInstall 23:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozleak 23:24:47 INFO - Running setup.py install for mozlog 23:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for moznetwork 23:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozprocess 23:24:47 INFO - Running setup.py install for mozprofile 23:24:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozrunner 23:24:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozscreenshot 23:24:47 INFO - Running setup.py install for moztest 23:24:48 INFO - Running setup.py install for mozversion 23:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:48 INFO - Cleaning up... 23:24:48 INFO - Return code: 0 23:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:48 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:48 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 23:24:48 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 23:24:48 INFO - Using env: {'DISPLAY': ':0', 23:24:48 INFO - 'HOME': '/home/cltbld', 23:24:48 INFO - 'LANG': 'en_US.UTF-8', 23:24:48 INFO - 'LANGUAGE': 'en_US:en', 23:24:48 INFO - 'LOGNAME': 'cltbld', 23:24:48 INFO - 'MAIL': '/var/mail/cltbld', 23:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:48 INFO - 'MOZ_NO_REMOTE': '1', 23:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:48 INFO - 'NO_EM_RESTART': '1', 23:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:48 INFO - 'PWD': '/builds/slave/test', 23:24:48 INFO - 'SHELL': '/bin/bash', 23:24:48 INFO - 'SHLVL': '1', 23:24:48 INFO - 'TERM': 'linux', 23:24:48 INFO - 'TMOUT': '86400', 23:24:48 INFO - 'USER': 'cltbld', 23:24:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:48 INFO - '_': '/tools/buildbot/bin/python'} 23:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:48 INFO - Running setup.py (path:/tmp/pip-1LdCVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:48 INFO - Running setup.py (path:/tmp/pip-w_SwqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:48 INFO - Running setup.py (path:/tmp/pip-1Penp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:48 INFO - Running setup.py (path:/tmp/pip-78_68N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:48 INFO - Running setup.py (path:/tmp/pip-JncpoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:48 INFO - Running setup.py (path:/tmp/pip-hSYiT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:48 INFO - Running setup.py (path:/tmp/pip-m5JHq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:48 INFO - Running setup.py (path:/tmp/pip-XuDilL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:48 INFO - Running setup.py (path:/tmp/pip-59WN2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:49 INFO - Running setup.py (path:/tmp/pip-UYqadP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:49 INFO - Running setup.py (path:/tmp/pip-1crDr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:49 INFO - Running setup.py (path:/tmp/pip-5dgPIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 INFO - Running setup.py (path:/tmp/pip-CHFhLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 INFO - Running setup.py (path:/tmp/pip-RX2Ufw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 INFO - Running setup.py (path:/tmp/pip-D9GtdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:49 INFO - Running setup.py (path:/tmp/pip-soVV38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:49 INFO - Running setup.py (path:/tmp/pip-flHhsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:49 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)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:49 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)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:49 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 23:24:49 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 23:24:49 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 23:24:49 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 23:24:49 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 23:24:49 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 23:24:51 INFO - Downloading blessings-1.6.tar.gz 23:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:51 INFO - Installing collected packages: blessings 23:24:51 INFO - Running setup.py install for blessings 23:24:51 INFO - Successfully installed blessings 23:24:51 INFO - Cleaning up... 23:24:51 INFO - Return code: 0 23:24:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:51 INFO - Reading from file tmpfile_stdout 23:24:51 INFO - Current package versions: 23:24:51 INFO - argparse == 1.2.1 23:24:51 INFO - blessings == 1.6 23:24:51 INFO - blobuploader == 1.2.4 23:24:51 INFO - docopt == 0.6.1 23:24:51 INFO - functools32 == 3.2.3-2 23:24:51 INFO - jsonschema == 2.5.1 23:24:51 INFO - manifestparser == 1.1 23:24:51 INFO - mozInstall == 1.12 23:24:51 INFO - mozcrash == 0.17 23:24:51 INFO - mozdebug == 0.1 23:24:51 INFO - mozdevice == 0.48 23:24:51 INFO - mozfile == 1.2 23:24:51 INFO - mozhttpd == 0.7 23:24:51 INFO - mozinfo == 0.9 23:24:51 INFO - mozleak == 0.1 23:24:51 INFO - mozlog == 3.4 23:24:51 INFO - moznetwork == 0.27 23:24:51 INFO - mozprocess == 0.23 23:24:51 INFO - mozprofile == 0.28 23:24:51 INFO - mozrunner == 6.12 23:24:51 INFO - mozscreenshot == 0.1 23:24:51 INFO - mozsystemmonitor == 0.3 23:24:51 INFO - moztest == 0.7 23:24:51 INFO - mozversion == 1.4 23:24:51 INFO - psutil == 3.1.1 23:24:51 INFO - requests == 1.2.3 23:24:51 INFO - wsgiref == 0.1.2 23:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:51 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:51 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 23:24:51 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 23:24:51 INFO - Using env: {'DISPLAY': ':0', 23:24:51 INFO - 'HOME': '/home/cltbld', 23:24:51 INFO - 'LANG': 'en_US.UTF-8', 23:24:51 INFO - 'LANGUAGE': 'en_US:en', 23:24:51 INFO - 'LOGNAME': 'cltbld', 23:24:51 INFO - 'MAIL': '/var/mail/cltbld', 23:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:51 INFO - 'MOZ_NO_REMOTE': '1', 23:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:51 INFO - 'NO_EM_RESTART': '1', 23:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:51 INFO - 'PWD': '/builds/slave/test', 23:24:51 INFO - 'SHELL': '/bin/bash', 23:24:51 INFO - 'SHLVL': '1', 23:24:51 INFO - 'TERM': 'linux', 23:24:51 INFO - 'TMOUT': '86400', 23:24:51 INFO - 'USER': 'cltbld', 23:24:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:51 INFO - '_': '/tools/buildbot/bin/python'} 23:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:52 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')]} 23:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 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')]} 23:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 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 0x7f4f4e293f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', '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 23:24:52 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 23:24:52 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 23:24:52 INFO - Using env: {'DISPLAY': ':0', 23:24:52 INFO - 'HOME': '/home/cltbld', 23:24:52 INFO - 'LANG': 'en_US.UTF-8', 23:24:52 INFO - 'LANGUAGE': 'en_US:en', 23:24:52 INFO - 'LOGNAME': 'cltbld', 23:24:52 INFO - 'MAIL': '/var/mail/cltbld', 23:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:52 INFO - 'MOZ_NO_REMOTE': '1', 23:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:52 INFO - 'NO_EM_RESTART': '1', 23:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:52 INFO - 'PWD': '/builds/slave/test', 23:24:52 INFO - 'SHELL': '/bin/bash', 23:24:52 INFO - 'SHLVL': '1', 23:24:52 INFO - 'TERM': 'linux', 23:24:52 INFO - 'TMOUT': '86400', 23:24:52 INFO - 'USER': 'cltbld', 23:24:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:52 INFO - '_': '/tools/buildbot/bin/python'} 23:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Running post-action listener: _resource_record_post_action 23:24:52 INFO - Running post-action listener: _start_resource_monitoring 23:24:52 INFO - Starting resource monitoring. 23:24:52 INFO - [mozharness: 2016-10-22 06:24:52.464661Z] Finished create-virtualenv step (success) 23:24:52 INFO - [mozharness: 2016-10-22 06:24:52.465114Z] Running install step. 23:24:52 INFO - Running pre-action listener: _resource_record_pre_action 23:24:52 INFO - Running main action method: install 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:52 INFO - Reading from file tmpfile_stdout 23:24:52 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:52 INFO - Reading from file tmpfile_stdout 23:24:52 INFO - Output received: 23:24:52 INFO - Usage: mozinstall [options] installer 23:24:52 INFO - Options: 23:24:52 INFO - -h, --help show this help message and exit 23:24:52 INFO - -d DEST, --destination=DEST 23:24:52 INFO - Directory to install application into. [default: 23:24:52 INFO - "/builds/slave/test"] 23:24:52 INFO - --app=APP Application being installed. [default: firefox] 23:24:52 INFO - mkdir: /builds/slave/test/build/application 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:25:08 INFO - Reading from file tmpfile_stdout 23:25:08 INFO - Output received: 23:25:08 INFO - /builds/slave/test/build/application/firefox/firefox 23:25:08 INFO - Running post-action listener: _resource_record_post_action 23:25:08 INFO - [mozharness: 2016-10-22 06:25:08.730582Z] Finished install step (success) 23:25:08 INFO - [mozharness: 2016-10-22 06:25:08.730828Z] Running run-tests step. 23:25:08 INFO - Running pre-action listener: _resource_record_pre_action 23:25:08 INFO - Running main action method: run_tests 23:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:08 INFO - Python 2.7.3 23:25:08 INFO - Return code: 0 23:25:08 INFO - grabbing minidump binary from tooltool 23:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:25:08 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 0x121bf60>, '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 0x121cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:08 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 23:25:08 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 23:25:08 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 23:25:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:08 INFO - Return code: 0 23:25:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:25:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:25:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 23:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 23:25:08 INFO - Using env: {'DISPLAY': ':0', 23:25:08 INFO - 'HOME': '/home/cltbld', 23:25:08 INFO - 'LANG': 'en_US.UTF-8', 23:25:08 INFO - 'LANGUAGE': 'en_US:en', 23:25:08 INFO - 'LOGNAME': 'cltbld', 23:25:08 INFO - 'MAIL': '/var/mail/cltbld', 23:25:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:08 INFO - 'MOZ_NO_REMOTE': '1', 23:25:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:08 INFO - 'NO_EM_RESTART': '1', 23:25:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:08 INFO - 'PWD': '/builds/slave/test', 23:25:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:08 INFO - 'SHELL': '/bin/bash', 23:25:08 INFO - 'SHLVL': '1', 23:25:08 INFO - 'TERM': 'linux', 23:25:08 INFO - 'TMOUT': '86400', 23:25:08 INFO - 'USER': 'cltbld', 23:25:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209', 23:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:08 INFO - '_': '/tools/buildbot/bin/python'} 23:25:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 23:25:09 INFO - mozversion application_buildid: 20161021204522 23:25:09 INFO - mozversion application_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 23:25:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:25:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:09 INFO - mozversion application_name: Firefox 23:25:09 INFO - mozversion application_remotingname: firefox-dev 23:25:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:25:09 INFO - mozversion application_vendor: Mozilla 23:25:09 INFO - mozversion application_version: 51.0a2 23:25:09 INFO - mozversion platform_buildid: 20161021204522 23:25:09 INFO - mozversion platform_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 23:25:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:25:09 INFO - mozversion platform_version: 51.0a2 23:25:09 INFO - using testdate: 1477117509 23:25:09 INFO - actual date: 1477117509 23:25:09 INFO - starting webserver on 'localhost:35472' 23:25:09 INFO - SUITE-START | Running 2 tests 23:25:09 INFO - TEST-START | dromaeo_css 23:25:09 INFO - operating with platform_type : linux_ 23:25:09 INFO - Initialising browser for dromaeo_css test... 23:25:09 INFO - TEST-INFO | started process 19483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfW3Yv5/profile http://localhost:35472/getInfo.html) 23:25:12 INFO - PROCESS | 19483 | __metrics Screen width/height:1600/1200 23:25:12 INFO - PROCESS | 19483 | colorDepth:24 23:25:12 INFO - PROCESS | 19483 | Browser inner width/height: 1024/697 23:25:12 INFO - PROCESS | 19483 | __metrics 23:25:13 INFO - PROCESS | 19483 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:25:13 INFO - PROCESS | 19483 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:25:13 INFO - PROCESS | 19483 | console.error: PushService: 23:25:13 INFO - PROCESS | 19483 | stateChangeProcessEnqueue: Error transitioning state 23:25:13 INFO - PROCESS | 19483 | UnknownError 23:25:14 INFO - TEST-INFO | 19483: exit 0 23:25:14 INFO - Browser initialized. 23:25:14 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:14 INFO - TEST-INFO | started process 19574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfW3Yv5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:26 INFO - PROCESS | 19574 | RSS: Main: 144568320 23:25:26 INFO - PROCESS | 19574 | 23:26:17 INFO - PROCESS | 19574 | 1477117577209 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] 23:28:26 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35472/tests/dromaeo/cssquery-ext.html) 23:28:27 INFO - PROCESS | 19574 | RSS: Main: 245637120 23:28:27 INFO - PROCESS | 19574 | 23:31:29 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-ext.html (next: http://localhost:35472/tests/dromaeo/cssquery-jquery.html) 23:31:29 INFO - PROCESS | 19574 | RSS: Main: 224751616 23:31:29 INFO - PROCESS | 19574 | 23:34:31 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35472/tests/dromaeo/cssquery-mootools.html) 23:34:32 INFO - PROCESS | 19574 | RSS: Main: 199266304 23:34:32 INFO - PROCESS | 19574 | 23:37:34 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35472/tests/dromaeo/cssquery-prototype.html) 23:37:35 INFO - PROCESS | 19574 | RSS: Main: 216940544 23:37:35 INFO - PROCESS | 19574 | 23:40:37 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35472/tests/dromaeo/cssquery-yui.html) 23:40:38 INFO - PROCESS | 19574 | RSS: Main: 176025600 23:40:38 INFO - PROCESS | 19574 | 23:43:40 INFO - PROCESS | 19574 | Cycle 1(1): loaded http://localhost:35472/tests/dromaeo/cssquery-yui.html (next: http://localhost:35472/tests/dromaeo/cssquery-dojo.html) 23:43:41 INFO - PROCESS | 19574 | RSS: Main: 260612096 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | __start_tp_report 23:43:41 INFO - PROCESS | 19574 | _x_x_mozilla_page_load 23:43:41 INFO - PROCESS | 19574 | _x_x_mozilla_page_load_details 23:43:41 INFO - PROCESS | 19574 | |i|pagename|runs| 23:43:41 INFO - PROCESS | 19574 | |0;dojo.html;3077.553754705568;3112.1908303841;3125.9062228133166;3148.212946763309;3162.7153556179956;5399.919001214985;5446.074167391543;5478.863028424292;5480.862978425532;5527.474889885464;5519.641223320491;5536.446355364462;5542.91685624716;5557.6109672322955;5558.333000039991;4976.75116244189;4993.425756038047;5008.29883816266;5044.899102017957;5080.949190508103;4899.461059283476;5028.899422011557;5078.466760990098;5084.644074914758;5106.591472682177;4878.536539028804;4908.141075311824;4920.188168952119;4939.67892087015;4940.481249468808;4975.253711943201;4998.025385049898;5002.9493806300725;5055.87360315995;5076.873078173038;4815.831445899412;4944.208926571767;4961.280614310905;5000.899982000376;5019.899602007976;5303.628745987782;5352.384475785296;5358.651687640291;5379.65032272901;5443.863903402407;5703.31560212773;5709.743061562198;5765.798197063083;5785.62393444429;5791.102379131242;5638.267025286727;5819.592628516006;5830.883382332372;5837.357890632027;5839.883202335929;5289;5447.4824891635235;5483.862903427366;5489.725513724298;5528.032594295983;6041.909371359433;6067.969660151759;6074.179985701874;6075.483583895419;6081.787137450168;5609.382967873531;5817.7382017809305;5821.650700957956;5822.941770582324;5825.592208545361;5670.603057785916;5690.345610254791;5697.401772813795;5710.628809127476;5802.709864506758;5767.509761670305;5770.307563092372;5776.913346299809;5777.971110144506;5798.072308430631;5701.515371193495;5761.020626493506;5764.106563482667;5776.277965254343;5793.826185214451;4425.6238219751685;4449.17690227309;4456.3538286948215;4461.353103799931;4469.150861336336;3997.180577981565;4008.899777505586;4021;4027.9597204027586;4030.7380020299174;5525.033119204123;5529.391766905637;5536.086545719912;5537.861553461195;5560.638558493685;5678.659280443187;5701.2018317435595;5712.143178523172;5730.169125476783;5928.555358348141;5435.592330575223;5439.292891924025;5448.128299472065;5467.9453205467435;5481.698506582176;4865.635077369211;4880.755962201875;4910.288008238786;4923.359963204832;4955.306257124005;5908.852278692895;5913.379095195029;5934.495567876693;5965.463108320272;5973.104034394875;5854.268216472941;5908.291005079418;5910.497607703393;5949.464548190684;5949.613275137102;6006.489448396936;6073;6073.210482637229;6083.969580152071;6091.725872335667;5625.606207565431;5647.378788333198;5813.476787089182;5814.622049566765;5821.039528477754;5807.361190269152;5858.648481091148;5914.3198532167635;5962.9105563415715;6006.429389208019;5758.913616295675;5775.104858746901;5816.709164541671;5828.271466066742;5828.533717302521;5528.198411230269;5743.770249189985;5753.108268218432;5757.453041961007;5759.0209664356325;5464.863378415572;5664.178694089252;5686.43135686428;5700.657960522382;5814.825555233349;5802.4197580241635;5838.854028649148;5843.444872737083;5855.2973643163095;5859.560532959959;5493.176023596492;5539.224508568885;5691.573132015198;5705.857353566194;5725.51333136688 23:43:41 INFO - PROCESS | 19574 | |1;ext.html;584.5995493087236;604.2175382879171;611.7644706787885;630.4546567219355;645.4771634975673;33962.15094622633;45906.540934590645;46453;46527.534724652745;46559;49116;49386.50613493864;49439;49616.75191624046;49663.00673986518;8369.288610468118;9312.441253524794;9455.858162127573;9456.101670341306;9460.8580871287;8308.459950103224;10906.072983796386;11239.550417983271;11261.54953801847;11642.359670218177;11262.4368781561;11317.207795454322;11326.546938122465;11331.150163737711;11348.262362946423;11200.551977920873;11235.719107022309;11242.831357529643;11268.267562608404;11284.040856527165;11039.889601103967;11133.10935125188;11135.777284454347;11147.665570032912;11155.832662510069;46700;46938.76530617325;47068;47093;47096.5290347099;3776.7922764247955;3828.3683192273243;4011.538673052607;4052.3111071117983;4261.552536983634;33551.32897342039;35095.4735678965;35224.471632925524;35423.64576354255;35591.82204088963;4566.977165114186;4616.630669546462;4625.213713668684;4655.88360290992;4693.225617773063;357488;360484.19757901307;360624;360643;362188;62422.68788656119;62607;62685;62695.6865215671;62701.372986269555;40818.795906020874;41134.177316453504;41413.58586414097;42383.57616423858;65743;17118.058506781996;17307.3942412015;17324.39364622232;17324.480265592054;17327.133643317782;11975.221610595458;12077.698057548456;12711.237325760483;12948.417321220568;13073.15024523403;20303.796962030192;21178.152873884872;21327.253546125812;21373.358799236048;21506.139754409647;7528.284812942762;7558.2441755823975;7581.241875812485;7609.695612175562;7675.270849269311;904.2314033071837;939.33307351781;970.0832713086207;975.7658162041201;976.9071938165863;33475;35483.47134057793;35573.1106722334;35681.643183568354;36148;1124.3478782306242;1134.3420815926743;1137.4085475552665;1149.0807354116673;1216.1912328301757;17405.303787848345;17473.82526174722;17831.643367132845;17845.37541186052;17899.37352192667;557712;557727;559476;561349;562513;61482.385176148564;61823.6908815462;62046.68976655088;62183;62211.688941555;1322.6032190342858;1362.7002059547083;1411.5483045425572;1415.1014106042737;1451.6878871042566;33466.665333346355;35547.28905421929;35725.821370892976;35786.463203051455;36049.63950360463;53383.46616533785;54218.45781542134;54234;54246;54294.45705543052;443748;447533;447802;448182;553970;44897.55102448934;47922.76038619784;48324.516754832;48614.27078593753;49191.508084920126;53743;54129;54215;54636.33520795369;54695;42888.142237155706;43912.560874390845;43975.340369893835;44478.55521444874;45054.77472612747;42961.78519107385;43783.562164377945;44106.11787764291;44457;45803.54196457993;43781.78109109434;43927.560724392344;44198;44970.10059798851;45201.32198016967;38342.424863627624;39526.40710389289;39850.003749906486;40191.09138740854;40925.386119207644;29934.700652994063;30041;30505.54241686332;30511.237219069702;30559.388812223187 23:43:41 INFO - PROCESS | 19574 | |2;jquery.html;380.18260739410283;395.3792545703247;400.5233771811544;402.3341370032595;417.83215911527276;14440.494582689607;16433.75349369759;20105.597888042248;21003.47491312718;21099.26152584656;16484.505464836046;16974.405895793618;17011.234494447748;19123.713144302812;21131.154753809868;5511.311086114236;5880.059190529516;5893.970530147354;6108.694565271719;6118.541109416789;5822.1266809978415;5951.345352011275;6038.0942858571125;6099.81700548982;6100.755969761204;5816.389279125694;5995.700214989233;6036.426539478743;6074.179985701918;6077.392260773931;5970.104484327342;6023.006203976339;6026.548008899328;6029.065494848305;6035.788747393842;5271.710055946922;5340.703497496075;5429.049916264677;5436.075867102602;5443.156310771837;25235.24294271175;25448.236552903443;25452.618210726854;25460.490790184092;25562.616560751605;2545.7581529754643;2626.093997570835;2629.9474010519684;2813.4935711571907;3319.9502007469905;16191.919040404722;16928.91535542327;17114.82885171145;17369.826301736946;17593.296268149257;2150.4193867655645;2263.3549438409973;2288.222004518455;2293.059845463352;2325.5581439526436;69090.65454672744;75803;90817.54591227068;99400;104169;18403;18505.444836654653;19642.90178549098;19703.310384136486;19954;35878.82060589732;36006.8199659;36098.63901361005;36162;36208.63791362105;9559.665411710557;9987.350822196535;10018.799624007479;10218.335808172445;10223;8257.339412846957;8274.917250827415;8321.16788321163;8474.491530508189;8477.448965817202;9253.352265341362;9514.571844267024;9695.224382049419;9835.114839664464;9896.406215627085;3376.2572234108457;3432.467967465047;3540.345036168317;3684.5394325709285;3741.9812900935867;911.193593669594;941.4116177389132;987.2003677021492;1016.588281745894;1067.4982758103679;20439;20728.378148655564;20768.1692732289;20896.268630597857;20928.47678808042;1017.4658304390255;1021.4433133942019;1038.7091614347994;1059.6238335390826;1111.4998250787016;10673.46632668379;11130.610428634958;11668.533258669559;11689.123315751352;11738.237014594024;479826;480173;481501;483761;491841;62350.68824655848;90747.54626226959;93565;94252.52873735587;94258.05741942493;1002.6741309074434;1013.9087482126644;1022.6625213679467;1025.9435731034716;1027.4811220333684;17501.29994800245;18042.2783088675;18155.45533633993;18378.540536486697;18572.257109716;42959.57040429681;43428.78285608678;44623.33065004092;44640;45032.324515132954;59219;60635;60963.39036609577;61144.38855611565;62379;8903.688370906988;8957.372983891066;9048.27613790882;9195.494247816434;9267.814643707223;12745.872541274839;13226.801597975846;13433.66415839612;14093;14127.576172714835;12202.755944880875;12347.444365003776;12402.627921162379;12462.56381026696;12620.684482888002;11794.46924888365;12117;12161;12166;12617.495300188257;12359.50561977511;12445.813312800134;12509.56216532417;12596;12752.171108877894;8687.695930642398;9092;9163.312751543528;9216.769580760534;9427.434353938786;10539.63111291101;12282.201656892274;12489.812652810397;12582.937085314516;12876.549320773727 23:43:41 INFO - PROCESS | 19574 | |3;mootools.html;1347.158026233604;1467.1270593996576;1516.3631274864556;1603.9518814435564;1731.3593970231009;7365.373943214827;8305.91694083059;8511.489310641358;8577.785555361119;8909.331800114986;8682.262007729334;8786.253168480687;8794.340424468175;8797.86803197951;8820.073892241302;2391.5097405031925;2411.987940060297;2418.322869596507;2419.1532963462737;2424.624183251599;2363.5745565798147;2387.307680772574;2432.1001229545095;2434.7443518430578;2443.3402981195154;2364.6334818103223;2387.2122199674154;2397.1130681647815;2399.9040038398443;2407.5666380051584;2316.0388438797877;2320.6054970655027;2322.419395151212;2328.6972693549815;2349.8485741986474;2296.5751336002727;2311.5839148953182;2316.2124877541546;2323.361075704178;2323.384303159664;8266.628001739937;8565.48607083577;8653.307735381155;8656.177663121993;8674.392792504526;5188.143956247252;5454;5472;5492.478214569649;5510.559155267609;3417.128632198798;3419.81191034493;3428.639992800745;3435.7251419886347;3511.9648803511895;1242.726600147966;1268.3341245845913;1272.1858010873048;1292.573450761256;1301.8633043530483;11612.477438515287;11661.70845728855;11719.12106592009;11765.647030589096;11794.64616061511;4427.623651989553;4503.234450143484;4678.345031695565;4678.69588476748;4736.715797052119;9533.666321678707;9594.760130996781;9604.807903841884;9609.279304052225;9614.086661767122;5504.559635229172;5508.091164957817;5509.283793106951;5514.200440936042;5515.007298686275;4445.822167113344;4592.058627981256;4780.091782561302;4846.5153484651955;5066.214736715815;3876.5154355705536;3884.6503814656817;3994.1811928554575;4000.6199411055904;4014.2573623879093;1204.2232759869835;1205.572021932219;1205.8974987126016;1211.3640338822188;1244.1353259484752;1007.9395236285847;1021.4280003198232;1026.7484466305652;1032.0711359776262;1038.901304376083;5917.437843404869;6052.273727152769;6090.847728806815;6113.755449781959;6230.657313847782;484.81577000740197;493.68897594515227;500.2895887839277;505.9595232381401;506.4125614287409;4091.9335735454;4195.30777421722;4261.509926358446;4261.765602891809;4331.177076355482;10502.527386267637;10595.894041059644;10654.786904261871;11086.833697494383;11092.889071109346;11087.113030957504;11090.667279981613;11123.555057797597;11149.498272577754;11151.776964460665;7753.4572579919995;7791.337736292366;8062.113167551564;8119.269265765991;8151.225633564921;5954.910676339771;6065.181200538047;6151.292601350902;6159.23009623797;6257.68711564429;9940.155086817702;9948.651797187063;9957.153641940227;10097.697069087939;10104.797904042025;9252.53737313145;9585.041495850639;9598.088181622734;9733;9799.804003920024;6866.6566671667215;7027.789166325018;7584.203658615987;7787.883181752165;7964.283214510722;8235.547044912588;8650.178233067849;8657.52383618907;8699.478031318142;8719.91280087191;7406.111266648037;7493.4379921505015;7642.235776422313;7657.425693072931;7668.079830420385;7151.570905745672;7335.449841262033;7358.374538164316;7554.2823431773895;7600.125985511737;7262.31008054234;7269.491135620456;7291.4166866649475;7317.743878964211;7319.63401829917;5132.375981717808;5171.92242116361;5185.325907632135;5186.299849520266;5269.209618557247;5124.6412751108555;5187.610929180251;5200.193969934666;5270.947290527199;5280.947190528045 23:43:41 INFO - PROCESS | 19574 | |4;prototype.html;323.59065781786046;331.03998404626594;333.8464306419047;336.612895170554;339.0303731328401;5420.214068960004;5505;5505.807296744615;5509.421510741369;5521.0062188806;5127.33344665193;5285.286486324345;5286.841394758163;5399.838004859851;5453.23654688344;4261.424707664472;4273.743575385472;4274.358846173068;4286.699931004815;4313.28830742927;4254.8937276308225;4271.487421509423;4281.100968796541;4293.162833247518;4307.310830267143;3930.6265904739003;3948.486696729421;4216.198922204787;4250.808713607895;4257.5742425757335;4233.491980962273;4240.766757828318;4246.490421149467;4248.766317852533;4268.850590229327;3756.4740936268945;3790.3556395412847;3803.3724435468116;3804.8205056432594;3812.7902965336893;5143.305653736735;5253.579713622939;5287.625217443454;5315.7873685052555;5329.440408757064;4858.732769697665;4873.34209881665;4873.707577545323;4881.829135980259;4892.241702536113;5663.971680141614;5666.829995100154;5674.602777805555;5678.772849086032;5682.210103817284;4059.939100913489;4117.5882411758885;4153.813078411448;4166.250074986501;4191.497020357546;5883.499902508292;5891.351951285355;5911.965406053923;5913.970430147821;5928.555358348098;4248.851290204828;4256.404103425523;4262.573742625713;4266.957330426718;4268.189044081614;3934;4101.384792281182;4128.938065929014;4310.655147588248;4315.741055536678;4757.785899634525;4758.3100450434495;4769.475357710649;4769.948921963589;4781.043791241766;5700.714964251771;5704.971475142681;5722.713864306768;5736.483716465538;5752.6836024019085;1392.5752645443035;1416.9645758855904;1475.4614565683448;1482.5404124721372;1498.1385703220474;963.8506031565119;984.3503287829998;995.5962093448203;998.0767789794556;1000.3847633705365;5462.918056229159;5474.890502189934;5479.287692599936;5495.34055913285;5515.393306736256;5623.785099195289;5815.79644712433;5824.301083869963;5846.327672317653;5858.94141058584;5442.265294185314;5451.64564303319;5461.836144915659;5474.91787623186;5477.643953143033;3085.3366526196974;3092.1960290324228;3093.783435159562;3094.7678924080783;3107.6270847497995;5707.771689132388;6005.879882402415;6009.759609615654;6044.425779550936;6088.330283668793;6042.214512113397;6055.273367195965;6059.363766804422;6061.242344706911;6071.453569178795;5803.65178089316;6103.42017508336;6108.725107370179;6108.908366374508;6133.447989680861;5880.852978675567;5918.556108291981;5923.7926672566255;5932.228810254639;5941.58408911372;5845.240118784531;5846.853828654318;5855.619384739978;5868.354481007171;5872.29532456108;5787.681677507778;6041.395860413923;6101.237345331833;6116.5718399711595;6142.662153581417;4247.93628095585;4248.682908298438;4266.232078225949;4272.658187345067;4276.87169384919;5730.914036289376;5910.172575839472;5932.436418540232;5935.9109613356695;5958.851028724316;5716.571257155647;5752.453516915886;5763.394843541368;5765.463196193661;5766.769329226784;5767.711614419346;5794.725160464691;5802.854928626818;5804.5356371491025;5813.56398270123;5348.197770334481;5356.027404790379;5645.322561292671;5673.205751194753;5689.829305120853;5731.742071606871;5747.453991870766;5748.166515855094;5766.740496677576;5769.9711501442225;5525.889482210414;5628.549716022627;5633.63381380209;5675.367764630557;5685.943140568706 23:43:41 INFO - PROCESS | 19574 | |5;yui.html;841.6507149532944;852.4075767341697;892.7901943043386;908.5048648486575;918.4902379179555;17038.23327950242;18117.81882181178;18125.184366703495;18130.637387252264;18144.455666330014;15982.280797364147;16260.268287927041;16401.097939613315;16416.17919104046;16421.91789041056;718.224317736843;730.6054730445579;824.0811495182858;847.720252316734;870.9782255443633;839.0560619303253;840.7393707950524;847.4957400346815;849.2908421468081;849.8300339932007;907.2696479334134;908.3823000359753;908.7001289574424;908.7410088124885;909.068205089785;749.9550026998397;766.9194734552875;872.0451106038909;880.8062226310202;892.7857314244535;664.933506649336;665.3080795972184;665.4809248785955;665.5574043261225;665.5873358517701;16221.675566488604;16226.513204603882;16269.593260168473;16282.02307861532;16304.184790760533;14805.925970370186;14920.328585213583;15193.316300766492;15395.07629542231;15434.305456254495;14014.649633759136;14129.222892740896;14590.854091459056;14685.853141468662;14817.18505482198;4189.790510474464;4225.302825033866;4308.116836048603;4357.302831546969;4358.411614432042;84535;86172.56913715454;86532.13467865303;86768.56615716881;87385.12614873833;11591.188616796911;11675.76648467026;11812.055035597132;11886.28682279066;12943.352832358345;23322.65016024761;23636;23742.525149497258;23768.524629507312;23775.286741397787;8903.51030693305;8939.910600893907;9017.233535149586;9056.094390560891;9231.907680923105;4992.638930885273;5006.824761133343;5042.243663450512;5056.620753443506;5281.12861377876;3422.110251334671;3542.3977923753023;3543.114221444639;3547.467879818048;3549.361114999325;632.7247647273451;642.5181114164377;642.6979319719725;645.8353119954476;685.9744681700889;709.9574025558379;766.5860435364953;772.5828052851509;810.5420437452821;831.9376046796515;10737.51681174349;10970.232083754221;11036.227464077438;11394.94302528482;11469.483873225725;662.8641128568631;763.7594157840374;797.3342259213506;809.5749731390949;809.6963638635511;4924.532169443897;5429.728513574306;5442.102053161184;5451.918221226685;5475.479829416199;122485.38757306157;124943.37528312301;126965;128567;132142;94075.52962235281;111714;114760;116051;118222;81556;86524.5673771627;98913.50543247238;103062.48468757758;103981;9536;9536.32588609776;9567.665131720634;9624.470654113811;10074.19406447497;46745.766271168424;47417.28874066823;53795.19307210473;55226;55668.721656391455;55740.721296394884;78526.6073669628;80409.19590804251;82491.58754206191;83334.58332708298;14039.929800350932;14294.857051429353;14490.782638260223;14548.709025819637;14737.410503580166;15111.395544178109;15945.395879870935;15974.680506389575;17259.36745461585;17288;14752.852471475147;14783.482578109715;14994.400223990919;15102.39590416371;15194.544163675107;14558.636034098809;15036.398544058115;15429.691406172038;15465.226738663247;16157;14395.928020359832;15236.390544378544;15240.009399389004;15686.843131568994;15930;10951.671449856518;11307.773844523228;11576.479058442223;11681.766364672829;11740.765184696087;11820.172587919107;12098.516059357527;12339.876601233873;12360.381980901098;12382.257064576153 23:43:41 INFO - PROCESS | 19574 | __end_tp_report 23:43:41 INFO - PROCESS | 19574 | __start_cc_report 23:43:41 INFO - PROCESS | 19574 | _x_x_mozilla_cycle_collect,832 23:43:41 INFO - PROCESS | 19574 | __end_cc_report 23:43:41 INFO - PROCESS | 19574 | __startTimestamp1477118621190__endTimestamp 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | ------- Summary: start ------- 23:43:41 INFO - PROCESS | 19574 | Number of tests: 6 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#0] dojo.html Cycles:165 Average:5420.66 Median:5647.38 stddev:618.10 (10.9%) stddev-sans-first:592.04 23:43:41 INFO - PROCESS | 19574 | Values: 3077.6 3112.2 3125.9 3148.2 3162.7 5399.9 5446.1 5478.9 5480.9 5527.5 5519.6 5536.4 5542.9 5557.6 5558.3 4976.8 4993.4 5008.3 5044.9 5080.9 4899.5 5028.9 5078.5 5084.6 5106.6 4878.5 4908.1 4920.2 4939.7 4940.5 4975.3 4998.0 5002.9 5055.9 5076.9 4815.8 4944.2 4961.3 5000.9 5019.9 5303.6 5352.4 5358.7 5379.7 5443.9 5703.3 5709.7 5765.8 5785.6 5791.1 5638.3 5819.6 5830.9 5837.4 5839.9 5289.0 5447.5 5483.9 5489.7 5528.0 6041.9 6068.0 6074.2 6075.5 6081.8 5609.4 5817.7 5821.7 5822.9 5825.6 5670.6 5690.3 5697.4 5710.6 5802.7 5767.5 5770.3 5776.9 5778.0 5798.1 5701.5 5761.0 5764.1 5776.3 5793.8 4425.6 4449.2 4456.4 4461.4 4469.2 3997.2 4008.9 4021.0 4028.0 4030.7 5525.0 5529.4 5536.1 5537.9 5560.6 5678.7 5701.2 5712.1 5730.2 5928.6 5435.6 5439.3 5448.1 5467.9 5481.7 4865.6 4880.8 4910.3 4923.4 4955.3 5908.9 5913.4 5934.5 5965.5 5973.1 5854.3 5908.3 5910.5 5949.5 5949.6 6006.5 6073.0 6073.2 6084.0 6091.7 5625.6 5647.4 5813.5 5814.6 5821.0 5807.4 5858.6 5914.3 5962.9 6006.4 5758.9 5775.1 5816.7 5828.3 5828.5 5528.2 5743.8 5753.1 5757.5 5759.0 5464.9 5664.2 5686.4 5700.7 5814.8 5802.4 5838.9 5843.4 5855.3 5859.6 5493.2 5539.2 5691.6 5705.9 5725.5 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#1] ext.html Cycles:180 Average:64069.76 Median:43371.78 stddev:124532.23 (287.1%) stddev-sans-first:124790.35 23:43:41 INFO - PROCESS | 19574 | Values: 584.6 604.2 611.8 630.5 645.5 33962.2 45906.5 46453.0 46527.5 46559.0 49116.0 49386.5 49439.0 49616.8 49663.0 8369.3 9312.4 9455.9 9456.1 9460.9 8308.5 10906.1 11239.6 11261.5 11642.4 11262.4 11317.2 11326.5 11331.2 11348.3 11200.6 11235.7 11242.8 11268.3 11284.0 11039.9 11133.1 11135.8 11147.7 11155.8 46700.0 46938.8 47068.0 47093.0 47096.5 3776.8 3828.4 4011.5 4052.3 4261.6 33551.3 35095.5 35224.5 35423.6 35591.8 4567.0 4616.6 4625.2 4655.9 4693.2 357488.0 360484.2 360624.0 360643.0 362188.0 62422.7 62607.0 62685.0 62695.7 62701.4 40818.8 41134.2 41413.6 42383.6 65743.0 17118.1 17307.4 17324.4 17324.5 17327.1 11975.2 12077.7 12711.2 12948.4 13073.2 20303.8 21178.2 21327.3 21373.4 21506.1 7528.3 7558.2 7581.2 7609.7 7675.3 904.2 939.3 970.1 975.8 976.9 33475.0 35483.5 35573.1 35681.6 36148.0 1124.3 1134.3 1137.4 1149.1 1216.2 17405.3 17473.8 17831.6 17845.4 17899.4 557712.0 557727.0 559476.0 561349.0 562513.0 61482.4 61823.7 62046.7 62183.0 62211.7 1322.6 1362.7 1411.5 1415.1 1451.7 33466.7 35547.3 35725.8 35786.5 36049.6 53383.5 54218.5 54234.0 54246.0 54294.5 443748.0 447533.0 447802.0 448182.0 553970.0 44897.6 47922.8 48324.5 48614.3 49191.5 53743.0 54129.0 54215.0 54636.3 54695.0 42888.1 43912.6 43975.3 44478.6 45054.8 42961.8 43783.6 44106.1 44457.0 45803.5 43781.8 43927.6 44198.0 44970.1 45201.3 38342.4 39526.4 39850.0 40191.1 40925.4 29934.7 30041.0 30505.5 30511.2 30559.4 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#2] jquery.html Cycles:180 Average:30513.13 Median:3348.10 stddev:79644.02 (2378.8%) stddev-sans-first:79835.31 23:43:41 INFO - PROCESS | 19574 | Values: 380.2 395.4 400.5 402.3 417.8 14440.5 16433.8 20105.6 21003.5 21099.3 16484.5 16974.4 17011.2 19123.7 21131.2 5511.3 5880.1 5894.0 6108.7 6118.5 5822.1 5951.3 6038.1 6099.8 6100.8 5816.4 5995.7 6036.4 6074.2 6077.4 5970.1 6023.0 6026.5 6029.1 6035.8 5271.7 5340.7 5429.0 5436.1 5443.2 25235.2 25448.2 25452.6 25460.5 25562.6 2545.8 2626.1 2629.9 2813.5 3320.0 16191.9 16928.9 17114.8 17369.8 17593.3 2150.4 2263.4 2288.2 2293.1 2325.6 69090.7 75803.0 90817.5 99400.0 104169.0 18403.0 18505.4 19642.9 19703.3 19954.0 35878.8 36006.8 36098.6 36162.0 36208.6 9559.7 9987.4 10018.8 10218.3 10223.0 8257.3 8274.9 8321.2 8474.5 8477.4 9253.4 9514.6 9695.2 9835.1 9896.4 3376.3 3432.5 3540.3 3684.5 3742.0 911.2 941.4 987.2 1016.6 1067.5 20439.0 20728.4 20768.2 20896.3 20928.5 1017.5 1021.4 1038.7 1059.6 1111.5 10673.5 11130.6 11668.5 11689.1 11738.2 479826.0 480173.0 481501.0 483761.0 491841.0 62350.7 90747.5 93565.0 94252.5 94258.1 1002.7 1013.9 1022.7 1025.9 1027.5 17501.3 18042.3 18155.5 18378.5 18572.3 42959.6 43428.8 44623.3 44640.0 45032.3 59219.0 60635.0 60963.4 61144.4 62379.0 8903.7 8957.4 9048.3 9195.5 9267.8 12745.9 13226.8 13433.7 14093.0 14127.6 12202.8 12347.4 12402.6 12462.6 12620.7 11794.5 12117.0 12161.0 12166.0 12617.5 12359.5 12445.8 12509.6 12596.0 12752.2 8687.7 9092.0 9163.3 9216.8 9427.4 10539.6 12282.2 12489.8 12582.9 12876.5 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#3] mootools.html Cycles:180 Average:5741.14 Median:2786.31 stddev:3196.83 (114.7%) stddev-sans-first:3188.74 23:43:41 INFO - PROCESS | 19574 | Values: 1347.2 1467.1 1516.4 1604.0 1731.4 7365.4 8305.9 8511.5 8577.8 8909.3 8682.3 8786.3 8794.3 8797.9 8820.1 2391.5 2412.0 2418.3 2419.2 2424.6 2363.6 2387.3 2432.1 2434.7 2443.3 2364.6 2387.2 2397.1 2399.9 2407.6 2316.0 2320.6 2322.4 2328.7 2349.8 2296.6 2311.6 2316.2 2323.4 2323.4 8266.6 8565.5 8653.3 8656.2 8674.4 5188.1 5454.0 5472.0 5492.5 5510.6 3417.1 3419.8 3428.6 3435.7 3512.0 1242.7 1268.3 1272.2 1292.6 1301.9 11612.5 11661.7 11719.1 11765.6 11794.6 4427.6 4503.2 4678.3 4678.7 4736.7 9533.7 9594.8 9604.8 9609.3 9614.1 5504.6 5508.1 5509.3 5514.2 5515.0 4445.8 4592.1 4780.1 4846.5 5066.2 3876.5 3884.7 3994.2 4000.6 4014.3 1204.2 1205.6 1205.9 1211.4 1244.1 1007.9 1021.4 1026.7 1032.1 1038.9 5917.4 6052.3 6090.8 6113.8 6230.7 484.8 493.7 500.3 506.0 506.4 4091.9 4195.3 4261.5 4261.8 4331.2 10502.5 10595.9 10654.8 11086.8 11092.9 11087.1 11090.7 11123.6 11149.5 11151.8 7753.5 7791.3 8062.1 8119.3 8151.2 5954.9 6065.2 6151.3 6159.2 6257.7 9940.2 9948.7 9957.2 10097.7 10104.8 9252.5 9585.0 9598.1 9733.0 9799.8 6866.7 7027.8 7584.2 7787.9 7964.3 8235.5 8650.2 8657.5 8699.5 8719.9 7406.1 7493.4 7642.2 7657.4 7668.1 7151.6 7335.4 7358.4 7554.3 7600.1 7262.3 7269.5 7291.4 7317.7 7319.6 5132.4 5171.9 5185.3 5186.3 5269.2 5124.6 5187.6 5200.2 5270.9 5280.9 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#4] prototype.html Cycles:180 Average:4817.60 Median:5478.47 stddev:1416.76 (25.9%) stddev-sans-first:1380.00 23:43:41 INFO - PROCESS | 19574 | Values: 323.6 331.0 333.8 336.6 339.0 5420.2 5505.0 5505.8 5509.4 5521.0 5127.3 5285.3 5286.8 5399.8 5453.2 4261.4 4273.7 4274.4 4286.7 4313.3 4254.9 4271.5 4281.1 4293.2 4307.3 3930.6 3948.5 4216.2 4250.8 4257.6 4233.5 4240.8 4246.5 4248.8 4268.9 3756.5 3790.4 3803.4 3804.8 3812.8 5143.3 5253.6 5287.6 5315.8 5329.4 4858.7 4873.3 4873.7 4881.8 4892.2 5664.0 5666.8 5674.6 5678.8 5682.2 4059.9 4117.6 4153.8 4166.3 4191.5 5883.5 5891.4 5912.0 5914.0 5928.6 4248.9 4256.4 4262.6 4267.0 4268.2 3934.0 4101.4 4128.9 4310.7 4315.7 4757.8 4758.3 4769.5 4769.9 4781.0 5700.7 5705.0 5722.7 5736.5 5752.7 1392.6 1417.0 1475.5 1482.5 1498.1 963.9 984.4 995.6 998.1 1000.4 5462.9 5474.9 5479.3 5495.3 5515.4 5623.8 5815.8 5824.3 5846.3 5858.9 5442.3 5451.6 5461.8 5474.9 5477.6 3085.3 3092.2 3093.8 3094.8 3107.6 5707.8 6005.9 6009.8 6044.4 6088.3 6042.2 6055.3 6059.4 6061.2 6071.5 5803.7 6103.4 6108.7 6108.9 6133.4 5880.9 5918.6 5923.8 5932.2 5941.6 5845.2 5846.9 5855.6 5868.4 5872.3 5787.7 6041.4 6101.2 6116.6 6142.7 4247.9 4248.7 4266.2 4272.7 4276.9 5730.9 5910.2 5932.4 5935.9 5958.9 5716.6 5752.5 5763.4 5765.5 5766.8 5767.7 5794.7 5802.9 5804.5 5813.6 5348.2 5356.0 5645.3 5673.2 5689.8 5731.7 5747.5 5748.2 5766.7 5770.0 5525.9 5628.5 5633.6 5675.4 5685.9 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - PROCESS | 19574 | [#5] yui.html Cycles:180 Average:22716.66 Median:3548.41 stddev:32961.84 (928.9%) stddev-sans-first:33013.39 23:43:41 INFO - PROCESS | 19574 | Values: 841.7 852.4 892.8 908.5 918.5 17038.2 18117.8 18125.2 18130.6 18144.5 15982.3 16260.3 16401.1 16416.2 16421.9 718.2 730.6 824.1 847.7 871.0 839.1 840.7 847.5 849.3 849.8 907.3 908.4 908.7 908.7 909.1 750.0 766.9 872.0 880.8 892.8 664.9 665.3 665.5 665.6 665.6 16221.7 16226.5 16269.6 16282.0 16304.2 14805.9 14920.3 15193.3 15395.1 15434.3 14014.6 14129.2 14590.9 14685.9 14817.2 4189.8 4225.3 4308.1 4357.3 4358.4 84535.0 86172.6 86532.1 86768.6 87385.1 11591.2 11675.8 11812.1 11886.3 12943.4 23322.7 23636.0 23742.5 23768.5 23775.3 8903.5 8939.9 9017.2 9056.1 9231.9 4992.6 5006.8 5042.2 5056.6 5281.1 3422.1 3542.4 3543.1 3547.5 3549.4 632.7 642.5 642.7 645.8 686.0 710.0 766.6 772.6 810.5 831.9 10737.5 10970.2 11036.2 11394.9 11469.5 662.9 763.8 797.3 809.6 809.7 4924.5 5429.7 5442.1 5451.9 5475.5 122485.4 124943.4 126965.0 128567.0 132142.0 94075.5 111714.0 114760.0 116051.0 118222.0 81556.0 86524.6 98913.5 103062.5 103981.0 9536.0 9536.3 9567.7 9624.5 10074.2 46745.8 47417.3 53795.2 55226.0 55668.7 55740.7 78526.6 80409.2 82491.6 83334.6 14039.9 14294.9 14490.8 14548.7 14737.4 15111.4 15945.4 15974.7 17259.4 17288.0 14752.9 14783.5 14994.4 15102.4 15194.5 14558.6 15036.4 15429.7 15465.2 16157.0 14395.9 15236.4 15240.0 15686.8 15930.0 10951.7 11307.8 11576.5 11681.8 11740.8 11820.2 12098.5 12339.9 12360.4 12382.3 23:43:41 INFO - PROCESS | 19574 | -------- Summary: end -------- 23:43:41 INFO - PROCESS | 19574 | 23:43:41 INFO - TEST-INFO | 19574: exit 0 23:43:41 INFO - TEST-OK | dromaeo_css | took 1112825ms 23:43:41 INFO - TEST-START | kraken 23:43:41 INFO - operating with platform_type : linux_ 23:43:41 INFO - Initialising browser for kraken test... 23:43:41 INFO - TEST-INFO | started process 19893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvLUiy/profile http://localhost:35472/getInfo.html) 23:43:45 INFO - PROCESS | 19893 | __metrics Screen width/height:1600/1200 23:43:45 INFO - PROCESS | 19893 | colorDepth:24 23:43:45 INFO - PROCESS | 19893 | Browser inner width/height: 1024/697 23:43:45 INFO - PROCESS | 19893 | __metrics 23:43:46 INFO - PROCESS | 19893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:43:46 INFO - PROCESS | 19893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:43:46 INFO - PROCESS | 19893 | console.error: PushService: 23:43:46 INFO - PROCESS | 19893 | stateChangeProcessEnqueue: Error transitioning state 23:43:46 INFO - PROCESS | 19893 | UnknownError 23:43:47 INFO - TEST-INFO | 19893: exit 0 23:43:47 INFO - Browser initialized. 23:43:47 INFO - Running cycle 1/1 for kraken test... 23:43:47 INFO - TEST-INFO | started process 19984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvLUiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:58 INFO - PROCESS | 19984 | RSS: Main: 144568320 23:43:58 INFO - PROCESS | 19984 | 23:44:01 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35472/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:02 INFO - PROCESS | 19984 | RSS: Main: 186105856 23:44:02 INFO - PROCESS | 19984 | 23:44:04 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35472/tests/kraken/driver.html?testName=audio-dft) 23:44:05 INFO - PROCESS | 19984 | RSS: Main: 175742976 23:44:05 INFO - PROCESS | 19984 | 23:44:08 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35472/tests/kraken/driver.html?testName=audio-fft) 23:44:08 INFO - PROCESS | 19984 | RSS: Main: 266739712 23:44:08 INFO - PROCESS | 19984 | 23:44:10 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35472/tests/kraken/driver.html?testName=audio-oscillator) 23:44:11 INFO - PROCESS | 19984 | RSS: Main: 173797376 23:44:11 INFO - PROCESS | 19984 | 23:44:13 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:14 INFO - PROCESS | 19984 | RSS: Main: 175624192 23:44:14 INFO - PROCESS | 19984 | 23:44:17 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35472/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:17 INFO - PROCESS | 19984 | RSS: Main: 211009536 23:44:17 INFO - PROCESS | 19984 | 23:44:21 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35472/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:21 INFO - PROCESS | 19984 | RSS: Main: 209870848 23:44:21 INFO - PROCESS | 19984 | 23:44:24 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35472/tests/kraken/driver.html?testName=json-parse-financial) 23:44:25 INFO - PROCESS | 19984 | RSS: Main: 210149376 23:44:25 INFO - PROCESS | 19984 | 23:44:26 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:27 INFO - PROCESS | 19984 | RSS: Main: 171782144 23:44:27 INFO - PROCESS | 19984 | 23:44:28 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:29 INFO - PROCESS | 19984 | RSS: Main: 179826688 23:44:29 INFO - PROCESS | 19984 | 23:44:31 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:31 INFO - PROCESS | 19984 | RSS: Main: 189079552 23:44:31 INFO - PROCESS | 19984 | 23:44:34 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:35 INFO - PROCESS | 19984 | RSS: Main: 196878336 23:44:35 INFO - PROCESS | 19984 | 23:44:37 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:38 INFO - PROCESS | 19984 | RSS: Main: 193449984 23:44:38 INFO - PROCESS | 19984 | 23:44:39 INFO - PROCESS | 19984 | Cycle 1(1): loaded http://localhost:35472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35472/tests/kraken/driver.html?testName=ai-astar) 23:44:40 INFO - PROCESS | 19984 | RSS: Main: 244404224 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | __start_tp_report 23:44:40 INFO - PROCESS | 19984 | _x_x_mozilla_page_load 23:44:40 INFO - PROCESS | 19984 | _x_x_mozilla_page_load_details 23:44:40 INFO - PROCESS | 19984 | |i|pagename|runs| 23:44:40 INFO - PROCESS | 19984 | |0;ai-astar;109;110;112;110;111;113;110;112;111;112 23:44:40 INFO - PROCESS | 19984 | |1;audio-beat-detection;151;117;117;147;120;117;121;117;145;121 23:44:40 INFO - PROCESS | 19984 | |2;audio-dft;160;160;160;160;159;161;161;159;161;160 23:44:40 INFO - PROCESS | 19984 | |3;audio-fft;75;76;76;124;75;75;74;85;109;76 23:44:40 INFO - PROCESS | 19984 | |4;audio-oscillator;82;81;107;80;81;81;112;81;81;110 23:44:40 INFO - PROCESS | 19984 | |5;imaging-gaussian-blur;116;117;117;116;118;117;116;117;117;118 23:44:40 INFO - PROCESS | 19984 | |6;imaging-darkroom;145;146;145;146;147;146;146;147;146;146 23:44:40 INFO - PROCESS | 19984 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;94 23:44:40 INFO - PROCESS | 19984 | |8;json-parse-financial;50;49;49;49;49;49;49;52;49;48 23:44:40 INFO - PROCESS | 19984 | |9;json-stringify-tinderbox;59;59;59;58;59;57;57;60;59;59 23:44:40 INFO - PROCESS | 19984 | |10;stanford-crypto-aes;72;74;72;73;73;80;74;79;76;80 23:44:40 INFO - PROCESS | 19984 | |11;stanford-crypto-ccm;123;122;123;124;118;132;119;118;161;133 23:44:40 INFO - PROCESS | 19984 | |12;stanford-crypto-pbkdf2;153;153;155;151;151;151;156;152;155;156 23:44:40 INFO - PROCESS | 19984 | |13;stanford-crypto-sha256-iterative;66;63;63;63;61;63;61;62;64;61 23:44:40 INFO - PROCESS | 19984 | __end_tp_report 23:44:40 INFO - PROCESS | 19984 | __start_cc_report 23:44:40 INFO - PROCESS | 19984 | _x_x_mozilla_cycle_collect,1601 23:44:40 INFO - PROCESS | 19984 | __end_cc_report 23:44:40 INFO - PROCESS | 19984 | __startTimestamp1477118680228__endTimestamp 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | ------- Summary: start ------- 23:44:40 INFO - PROCESS | 19984 | Number of tests: 14 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:1.25 (1.1%) stddev-sans-first:1.09 23:44:40 INFO - PROCESS | 19984 | Values: 109.0 110.0 112.0 110.0 111.0 113.0 110.0 112.0 111.0 112.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:121.00 stddev:14.22 (11.8%) stddev-sans-first:12.23 23:44:40 INFO - PROCESS | 19984 | Values: 151.0 117.0 117.0 147.0 120.0 117.0 121.0 117.0 145.0 121.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:44:40 INFO - PROCESS | 19984 | Values: 160.0 160.0 160.0 160.0 159.0 161.0 161.0 159.0 161.0 160.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.50 stddev:17.51 (23.2%) stddev-sans-first:18.23 23:44:40 INFO - PROCESS | 19984 | Values: 75.0 76.0 76.0 124.0 75.0 75.0 74.0 85.0 109.0 76.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.00 stddev:13.91 (17.2%) stddev-sans-first:14.48 23:44:40 INFO - PROCESS | 19984 | Values: 82.0 81.0 107.0 80.0 81.0 81.0 112.0 81.0 81.0 110.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 23:44:40 INFO - PROCESS | 19984 | Values: 116.0 117.0 117.0 116.0 118.0 117.0 116.0 117.0 117.0 118.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 23:44:40 INFO - PROCESS | 19984 | Values: 145.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 23:44:40 INFO - PROCESS | 19984 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 94.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:1.06 (2.2%) stddev-sans-first:1.09 23:44:40 INFO - PROCESS | 19984 | Values: 50.0 49.0 49.0 49.0 49.0 49.0 49.0 52.0 49.0 48.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 23:44:40 INFO - PROCESS | 19984 | Values: 59.0 59.0 59.0 58.0 59.0 57.0 57.0 60.0 59.0 59.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:3.23 (4.3%) stddev-sans-first:3.20 23:44:40 INFO - PROCESS | 19984 | Values: 72.0 74.0 72.0 73.0 73.0 80.0 74.0 79.0 76.0 80.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:123.50 stddev:12.94 (10.5%) stddev-sans-first:13.64 23:44:40 INFO - PROCESS | 19984 | Values: 123.0 122.0 123.0 124.0 118.0 132.0 119.0 118.0 161.0 133.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:154.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 23:44:40 INFO - PROCESS | 19984 | Values: 153.0 153.0 155.0 151.0 151.0 151.0 156.0 152.0 155.0 156.0 23:44:40 INFO - PROCESS | 19984 | 23:44:40 INFO - PROCESS | 19984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.12 23:44:40 INFO - PROCESS | 19984 | Values: 66.0 63.0 63.0 63.0 61.0 63.0 61.0 62.0 64.0 61.0 23:44:40 INFO - PROCESS | 19984 | -------- Summary: end -------- 23:44:40 INFO - PROCESS | 19984 | 23:44:41 INFO - TEST-INFO | 19984: exit 0 23:44:41 INFO - TEST-OK | kraken | took 59373ms 23:44:41 INFO - SUITE-END | took 1172s 23:44:41 INFO - Completed test suite (00:19:32) 23:44:41 INFO - javascript benchmark 23:44:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.553754705568, 3112.1908303841, 3125.9062228133166, 3148.212946763309, 3162.7153556179956, 5399.919001214985, 5446.074167391543, 5478.863028424292, 5480.862978425532, 5527.474889885464, 5519.641223320491, 5536.446355364462, 5542.91685624716, 5557.6109672322955, 5558.333000039991, 4976.75116244189, 4993.425756038047, 5008.29883816266, 5044.899102017957, 5080.949190508103, 4899.461059283476, 5028.899422011557, 5078.466760990098, 5084.644074914758, 5106.591472682177, 4878.536539028804, 4908.141075311824, 4920.188168952119, 4939.67892087015, 4940.481249468808, 4975.253711943201, 4998.025385049898, 5002.9493806300725, 5055.87360315995, 5076.873078173038, 4815.831445899412, 4944.208926571767, 4961.280614310905, 5000.899982000376, 5019.899602007976, 5303.628745987782, 5352.384475785296, 5358.651687640291, 5379.65032272901, 5443.863903402407, 5703.31560212773, 5709.743061562198, 5765.798197063083, 5785.62393444429, 5791.102379131242, 5638.267025286727, 5819.592628516006, 5830.883382332372, 5837.357890632027, 5839.883202335929, 5289.0, 5447.4824891635235, 5483.862903427366, 5489.725513724298, 5528.032594295983, 6041.909371359433, 6067.969660151759, 6074.179985701874, 6075.483583895419, 6081.787137450168, 5609.382967873531, 5817.7382017809305, 5821.650700957956, 5822.941770582324, 5825.592208545361, 5670.603057785916, 5690.345610254791, 5697.401772813795, 5710.628809127476, 5802.709864506758, 5767.509761670305, 5770.307563092372, 5776.913346299809, 5777.971110144506, 5798.072308430631, 5701.515371193495, 5761.020626493506, 5764.106563482667, 5776.277965254343, 5793.826185214451, 4425.6238219751685, 4449.17690227309, 4456.3538286948215, 4461.353103799931, 4469.150861336336, 3997.180577981565, 4008.899777505586, 4021.0, 4027.9597204027586, 4030.7380020299174, 5525.033119204123, 5529.391766905637, 5536.086545719912, 5537.861553461195, 5560.638558493685, 5678.659280443187, 5701.2018317435595, 5712.143178523172, 5730.169125476783, 5928.555358348141, 5435.592330575223, 5439.292891924025, 5448.128299472065, 5467.9453205467435, 5481.698506582176, 4865.635077369211, 4880.755962201875, 4910.288008238786, 4923.359963204832, 4955.306257124005, 5908.852278692895, 5913.379095195029, 5934.495567876693, 5965.463108320272, 5973.104034394875, 5854.268216472941, 5908.291005079418, 5910.497607703393, 5949.464548190684, 5949.613275137102, 6006.489448396936, 6073.0, 6073.210482637229, 6083.969580152071, 6091.725872335667, 5625.606207565431, 5647.378788333198, 5813.476787089182, 5814.622049566765, 5821.039528477754, 5807.361190269152, 5858.648481091148, 5914.3198532167635, 5962.9105563415715, 6006.429389208019, 5758.913616295675, 5775.104858746901, 5816.709164541671, 5828.271466066742, 5828.533717302521, 5528.198411230269, 5743.770249189985, 5753.108268218432, 5757.453041961007, 5759.0209664356325, 5464.863378415572, 5664.178694089252, 5686.43135686428, 5700.657960522382, 5814.825555233349, 5802.4197580241635, 5838.854028649148, 5843.444872737083, 5855.2973643163095, 5859.560532959959, 5493.176023596492, 5539.224508568885, 5691.573132015198, 5705.857353566194, 5725.51333136688], "value": 5378.620792502281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5995493087236, 604.2175382879171, 611.7644706787885, 630.4546567219355, 645.4771634975673, 33962.15094622633, 45906.540934590645, 46453.0, 46527.534724652745, 46559.0, 49116.0, 49386.50613493864, 49439.0, 49616.75191624046, 49663.00673986518, 8369.288610468118, 9312.441253524794, 9455.858162127573, 9456.101670341306, 9460.8580871287, 8308.459950103224, 10906.072983796386, 11239.550417983271, 11261.54953801847, 11642.359670218177, 11262.4368781561, 11317.207795454322, 11326.546938122465, 11331.150163737711, 11348.262362946423, 11200.551977920873, 11235.719107022309, 11242.831357529643, 11268.267562608404, 11284.040856527165, 11039.889601103967, 11133.10935125188, 11135.777284454347, 11147.665570032912, 11155.832662510069, 46700.0, 46938.76530617325, 47068.0, 47093.0, 47096.5290347099, 3776.7922764247955, 3828.3683192273243, 4011.538673052607, 4052.3111071117983, 4261.552536983634, 33551.32897342039, 35095.4735678965, 35224.471632925524, 35423.64576354255, 35591.82204088963, 4566.977165114186, 4616.630669546462, 4625.213713668684, 4655.88360290992, 4693.225617773063, 357488.0, 360484.19757901307, 360624.0, 360643.0, 362188.0, 62422.68788656119, 62607.0, 62685.0, 62695.6865215671, 62701.372986269555, 40818.795906020874, 41134.177316453504, 41413.58586414097, 42383.57616423858, 65743.0, 17118.058506781996, 17307.3942412015, 17324.39364622232, 17324.480265592054, 17327.133643317782, 11975.221610595458, 12077.698057548456, 12711.237325760483, 12948.417321220568, 13073.15024523403, 20303.796962030192, 21178.152873884872, 21327.253546125812, 21373.358799236048, 21506.139754409647, 7528.284812942762, 7558.2441755823975, 7581.241875812485, 7609.695612175562, 7675.270849269311, 904.2314033071837, 939.33307351781, 970.0832713086207, 975.7658162041201, 976.9071938165863, 33475.0, 35483.47134057793, 35573.1106722334, 35681.643183568354, 36148.0, 1124.3478782306242, 1134.3420815926743, 1137.4085475552665, 1149.0807354116673, 1216.1912328301757, 17405.303787848345, 17473.82526174722, 17831.643367132845, 17845.37541186052, 17899.37352192667, 557712.0, 557727.0, 559476.0, 561349.0, 562513.0, 61482.385176148564, 61823.6908815462, 62046.68976655088, 62183.0, 62211.688941555, 1322.6032190342858, 1362.7002059547083, 1411.5483045425572, 1415.1014106042737, 1451.6878871042566, 33466.665333346355, 35547.28905421929, 35725.821370892976, 35786.463203051455, 36049.63950360463, 53383.46616533785, 54218.45781542134, 54234.0, 54246.0, 54294.45705543052, 443748.0, 447533.0, 447802.0, 448182.0, 553970.0, 44897.55102448934, 47922.76038619784, 48324.516754832, 48614.27078593753, 49191.508084920126, 53743.0, 54129.0, 54215.0, 54636.33520795369, 54695.0, 42888.142237155706, 43912.560874390845, 43975.340369893835, 44478.55521444874, 45054.77472612747, 42961.78519107385, 43783.562164377945, 44106.11787764291, 44457.0, 45803.54196457993, 43781.78109109434, 43927.560724392344, 44198.0, 44970.10059798851, 45201.32198016967, 38342.424863627624, 39526.40710389289, 39850.003749906486, 40191.09138740854, 40925.386119207644, 29934.700652994063, 30041.0, 30505.54241686332, 30511.237219069702, 30559.388812223187], "value": 21845.71758741723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.18260739410283, 395.3792545703247, 400.5233771811544, 402.3341370032595, 417.83215911527276, 14440.494582689607, 16433.75349369759, 20105.597888042248, 21003.47491312718, 21099.26152584656, 16484.505464836046, 16974.405895793618, 17011.234494447748, 19123.713144302812, 21131.154753809868, 5511.311086114236, 5880.059190529516, 5893.970530147354, 6108.694565271719, 6118.541109416789, 5822.1266809978415, 5951.345352011275, 6038.0942858571125, 6099.81700548982, 6100.755969761204, 5816.389279125694, 5995.700214989233, 6036.426539478743, 6074.179985701918, 6077.392260773931, 5970.104484327342, 6023.006203976339, 6026.548008899328, 6029.065494848305, 6035.788747393842, 5271.710055946922, 5340.703497496075, 5429.049916264677, 5436.075867102602, 5443.156310771837, 25235.24294271175, 25448.236552903443, 25452.618210726854, 25460.490790184092, 25562.616560751605, 2545.7581529754643, 2626.093997570835, 2629.9474010519684, 2813.4935711571907, 3319.9502007469905, 16191.919040404722, 16928.91535542327, 17114.82885171145, 17369.826301736946, 17593.296268149257, 2150.4193867655645, 2263.3549438409973, 2288.222004518455, 2293.059845463352, 2325.5581439526436, 69090.65454672744, 75803.0, 90817.54591227068, 99400.0, 104169.0, 18403.0, 18505.444836654653, 19642.90178549098, 19703.310384136486, 19954.0, 35878.82060589732, 36006.8199659, 36098.63901361005, 36162.0, 36208.63791362105, 9559.665411710557, 9987.350822196535, 10018.799624007479, 10218.335808172445, 10223.0, 8257.339412846957, 8274.917250827415, 8321.16788321163, 8474.491530508189, 8477.448965817202, 9253.352265341362, 9514.571844267024, 9695.224382049419, 9835.114839664464, 9896.406215627085, 3376.2572234108457, 3432.467967465047, 3540.345036168317, 3684.5394325709285, 3741.9812900935867, 911.193593669594, 941.4116177389132, 987.2003677021492, 1016.588281745894, 1067.4982758103679, 20439.0, 20728.378148655564, 20768.1692732289, 20896.268630597857, 20928.47678808042, 1017.4658304390255, 1021.4433133942019, 1038.7091614347994, 1059.6238335390826, 1111.4998250787016, 10673.46632668379, 11130.610428634958, 11668.533258669559, 11689.123315751352, 11738.237014594024, 479826.0, 480173.0, 481501.0, 483761.0, 491841.0, 62350.68824655848, 90747.54626226959, 93565.0, 94252.52873735587, 94258.05741942493, 1002.6741309074434, 1013.9087482126644, 1022.6625213679467, 1025.9435731034716, 1027.4811220333684, 17501.29994800245, 18042.2783088675, 18155.45533633993, 18378.540536486697, 18572.257109716, 42959.57040429681, 43428.78285608678, 44623.33065004092, 44640.0, 45032.324515132954, 59219.0, 60635.0, 60963.39036609577, 61144.38855611565, 62379.0, 8903.688370906988, 8957.372983891066, 9048.27613790882, 9195.494247816434, 9267.814643707223, 12745.872541274839, 13226.801597975846, 13433.66415839612, 14093.0, 14127.576172714835, 12202.755944880875, 12347.444365003776, 12402.627921162379, 12462.56381026696, 12620.684482888002, 11794.46924888365, 12117.0, 12161.0, 12166.0, 12617.495300188257, 12359.50561977511, 12445.813312800134, 12509.56216532417, 12596.0, 12752.171108877894, 8687.695930642398, 9092.0, 9163.312751543528, 9216.769580760534, 9427.434353938786, 10539.63111291101, 12282.201656892274, 12489.812652810397, 12582.937085314516, 12876.549320773727], "value": 10503.058405023708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.158026233604, 1467.1270593996576, 1516.3631274864556, 1603.9518814435564, 1731.3593970231009, 7365.373943214827, 8305.91694083059, 8511.489310641358, 8577.785555361119, 8909.331800114986, 8682.262007729334, 8786.253168480687, 8794.340424468175, 8797.86803197951, 8820.073892241302, 2391.5097405031925, 2411.987940060297, 2418.322869596507, 2419.1532963462737, 2424.624183251599, 2363.5745565798147, 2387.307680772574, 2432.1001229545095, 2434.7443518430578, 2443.3402981195154, 2364.6334818103223, 2387.2122199674154, 2397.1130681647815, 2399.9040038398443, 2407.5666380051584, 2316.0388438797877, 2320.6054970655027, 2322.419395151212, 2328.6972693549815, 2349.8485741986474, 2296.5751336002727, 2311.5839148953182, 2316.2124877541546, 2323.361075704178, 2323.384303159664, 8266.628001739937, 8565.48607083577, 8653.307735381155, 8656.177663121993, 8674.392792504526, 5188.143956247252, 5454.0, 5472.0, 5492.478214569649, 5510.559155267609, 3417.128632198798, 3419.81191034493, 3428.639992800745, 3435.7251419886347, 3511.9648803511895, 1242.726600147966, 1268.3341245845913, 1272.1858010873048, 1292.573450761256, 1301.8633043530483, 11612.477438515287, 11661.70845728855, 11719.12106592009, 11765.647030589096, 11794.64616061511, 4427.623651989553, 4503.234450143484, 4678.345031695565, 4678.69588476748, 4736.715797052119, 9533.666321678707, 9594.760130996781, 9604.807903841884, 9609.279304052225, 9614.086661767122, 5504.559635229172, 5508.091164957817, 5509.283793106951, 5514.200440936042, 5515.007298686275, 4445.822167113344, 4592.058627981256, 4780.091782561302, 4846.5153484651955, 5066.214736715815, 3876.5154355705536, 3884.6503814656817, 3994.1811928554575, 4000.6199411055904, 4014.2573623879093, 1204.2232759869835, 1205.572021932219, 1205.8974987126016, 1211.3640338822188, 1244.1353259484752, 1007.9395236285847, 1021.4280003198232, 1026.7484466305652, 1032.0711359776262, 1038.901304376083, 5917.437843404869, 6052.273727152769, 6090.847728806815, 6113.755449781959, 6230.657313847782, 484.81577000740197, 493.68897594515227, 500.2895887839277, 505.9595232381401, 506.4125614287409, 4091.9335735454, 4195.30777421722, 4261.509926358446, 4261.765602891809, 4331.177076355482, 10502.527386267637, 10595.894041059644, 10654.786904261871, 11086.833697494383, 11092.889071109346, 11087.113030957504, 11090.667279981613, 11123.555057797597, 11149.498272577754, 11151.776964460665, 7753.4572579919995, 7791.337736292366, 8062.113167551564, 8119.269265765991, 8151.225633564921, 5954.910676339771, 6065.181200538047, 6151.292601350902, 6159.23009623797, 6257.68711564429, 9940.155086817702, 9948.651797187063, 9957.153641940227, 10097.697069087939, 10104.797904042025, 9252.53737313145, 9585.041495850639, 9598.088181622734, 9733.0, 9799.804003920024, 6866.6566671667215, 7027.789166325018, 7584.203658615987, 7787.883181752165, 7964.283214510722, 8235.547044912588, 8650.178233067849, 8657.52383618907, 8699.478031318142, 8719.91280087191, 7406.111266648037, 7493.4379921505015, 7642.235776422313, 7657.425693072931, 7668.079830420385, 7151.570905745672, 7335.449841262033, 7358.374538164316, 7554.2823431773895, 7600.125985511737, 7262.31008054234, 7269.491135620456, 7291.4166866649475, 7317.743878964211, 7319.63401829917, 5132.375981717808, 5171.92242116361, 5185.325907632135, 5186.299849520266, 5269.209618557247, 5124.6412751108555, 5187.610929180251, 5200.193969934666, 5270.947290527199, 5280.947190528045], "value": 4572.651383974644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.59065781786046, 331.03998404626594, 333.8464306419047, 336.612895170554, 339.0303731328401, 5420.214068960004, 5505.0, 5505.807296744615, 5509.421510741369, 5521.0062188806, 5127.33344665193, 5285.286486324345, 5286.841394758163, 5399.838004859851, 5453.23654688344, 4261.424707664472, 4273.743575385472, 4274.358846173068, 4286.699931004815, 4313.28830742927, 4254.8937276308225, 4271.487421509423, 4281.100968796541, 4293.162833247518, 4307.310830267143, 3930.6265904739003, 3948.486696729421, 4216.198922204787, 4250.808713607895, 4257.5742425757335, 4233.491980962273, 4240.766757828318, 4246.490421149467, 4248.766317852533, 4268.850590229327, 3756.4740936268945, 3790.3556395412847, 3803.3724435468116, 3804.8205056432594, 3812.7902965336893, 5143.305653736735, 5253.579713622939, 5287.625217443454, 5315.7873685052555, 5329.440408757064, 4858.732769697665, 4873.34209881665, 4873.707577545323, 4881.829135980259, 4892.241702536113, 5663.971680141614, 5666.829995100154, 5674.602777805555, 5678.772849086032, 5682.210103817284, 4059.939100913489, 4117.5882411758885, 4153.813078411448, 4166.250074986501, 4191.497020357546, 5883.499902508292, 5891.351951285355, 5911.965406053923, 5913.970430147821, 5928.555358348098, 4248.851290204828, 4256.404103425523, 4262.573742625713, 4266.957330426718, 4268.189044081614, 3934.0, 4101.384792281182, 4128.938065929014, 4310.655147588248, 4315.741055536678, 4757.785899634525, 4758.3100450434495, 4769.475357710649, 4769.948921963589, 4781.043791241766, 5700.714964251771, 5704.971475142681, 5722.713864306768, 5736.483716465538, 5752.6836024019085, 1392.5752645443035, 1416.9645758855904, 1475.4614565683448, 1482.5404124721372, 1498.1385703220474, 963.8506031565119, 984.3503287829998, 995.5962093448203, 998.0767789794556, 1000.3847633705365, 5462.918056229159, 5474.890502189934, 5479.287692599936, 5495.34055913285, 5515.393306736256, 5623.785099195289, 5815.79644712433, 5824.301083869963, 5846.327672317653, 5858.94141058584, 5442.265294185314, 5451.64564303319, 5461.836144915659, 5474.91787623186, 5477.643953143033, 3085.3366526196974, 3092.1960290324228, 3093.783435159562, 3094.7678924080783, 3107.6270847497995, 5707.771689132388, 6005.879882402415, 6009.759609615654, 6044.425779550936, 6088.330283668793, 6042.214512113397, 6055.273367195965, 6059.363766804422, 6061.242344706911, 6071.453569178795, 5803.65178089316, 6103.42017508336, 6108.725107370179, 6108.908366374508, 6133.447989680861, 5880.852978675567, 5918.556108291981, 5923.7926672566255, 5932.228810254639, 5941.58408911372, 5845.240118784531, 5846.853828654318, 5855.619384739978, 5868.354481007171, 5872.29532456108, 5787.681677507778, 6041.395860413923, 6101.237345331833, 6116.5718399711595, 6142.662153581417, 4247.93628095585, 4248.682908298438, 4266.232078225949, 4272.658187345067, 4276.87169384919, 5730.914036289376, 5910.172575839472, 5932.436418540232, 5935.9109613356695, 5958.851028724316, 5716.571257155647, 5752.453516915886, 5763.394843541368, 5765.463196193661, 5766.769329226784, 5767.711614419346, 5794.725160464691, 5802.854928626818, 5804.5356371491025, 5813.56398270123, 5348.197770334481, 5356.027404790379, 5645.322561292671, 5673.205751194753, 5689.829305120853, 5731.742071606871, 5747.453991870766, 5748.166515855094, 5766.740496677576, 5769.9711501442225, 5525.889482210414, 5628.549716022627, 5633.63381380209, 5675.367764630557, 5685.943140568706], "value": 4363.849537177578, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.6507149532944, 852.4075767341697, 892.7901943043386, 908.5048648486575, 918.4902379179555, 17038.23327950242, 18117.81882181178, 18125.184366703495, 18130.637387252264, 18144.455666330014, 15982.280797364147, 16260.268287927041, 16401.097939613315, 16416.17919104046, 16421.91789041056, 718.224317736843, 730.6054730445579, 824.0811495182858, 847.720252316734, 870.9782255443633, 839.0560619303253, 840.7393707950524, 847.4957400346815, 849.2908421468081, 849.8300339932007, 907.2696479334134, 908.3823000359753, 908.7001289574424, 908.7410088124885, 909.068205089785, 749.9550026998397, 766.9194734552875, 872.0451106038909, 880.8062226310202, 892.7857314244535, 664.933506649336, 665.3080795972184, 665.4809248785955, 665.5574043261225, 665.5873358517701, 16221.675566488604, 16226.513204603882, 16269.593260168473, 16282.02307861532, 16304.184790760533, 14805.925970370186, 14920.328585213583, 15193.316300766492, 15395.07629542231, 15434.305456254495, 14014.649633759136, 14129.222892740896, 14590.854091459056, 14685.853141468662, 14817.18505482198, 4189.790510474464, 4225.302825033866, 4308.116836048603, 4357.302831546969, 4358.411614432042, 84535.0, 86172.56913715454, 86532.13467865303, 86768.56615716881, 87385.12614873833, 11591.188616796911, 11675.76648467026, 11812.055035597132, 11886.28682279066, 12943.352832358345, 23322.65016024761, 23636.0, 23742.525149497258, 23768.524629507312, 23775.286741397787, 8903.51030693305, 8939.910600893907, 9017.233535149586, 9056.094390560891, 9231.907680923105, 4992.638930885273, 5006.824761133343, 5042.243663450512, 5056.620753443506, 5281.12861377876, 3422.110251334671, 3542.3977923753023, 3543.114221444639, 3547.467879818048, 3549.361114999325, 632.7247647273451, 642.5181114164377, 642.6979319719725, 645.8353119954476, 685.9744681700889, 709.9574025558379, 766.5860435364953, 772.5828052851509, 810.5420437452821, 831.9376046796515, 10737.51681174349, 10970.232083754221, 11036.227464077438, 11394.94302528482, 11469.483873225725, 662.8641128568631, 763.7594157840374, 797.3342259213506, 809.5749731390949, 809.6963638635511, 4924.532169443897, 5429.728513574306, 5442.102053161184, 5451.918221226685, 5475.479829416199, 122485.38757306157, 124943.37528312301, 126965.0, 128567.0, 132142.0, 94075.52962235281, 111714.0, 114760.0, 116051.0, 118222.0, 81556.0, 86524.5673771627, 98913.50543247238, 103062.48468757758, 103981.0, 9536.0, 9536.32588609776, 9567.665131720634, 9624.470654113811, 10074.19406447497, 46745.766271168424, 47417.28874066823, 53795.19307210473, 55226.0, 55668.721656391455, 55740.721296394884, 78526.6073669628, 80409.19590804251, 82491.58754206191, 83334.58332708298, 14039.929800350932, 14294.857051429353, 14490.782638260223, 14548.709025819637, 14737.410503580166, 15111.395544178109, 15945.395879870935, 15974.680506389575, 17259.36745461585, 17288.0, 14752.852471475147, 14783.482578109715, 14994.400223990919, 15102.39590416371, 15194.544163675107, 14558.636034098809, 15036.398544058115, 15429.691406172038, 15465.226738663247, 16157.0, 14395.928020359832, 15236.390544378544, 15240.009399389004, 15686.843131568994, 15930.0, 10951.671449856518, 11307.773844523228, 11576.479058442223, 11681.766364672829, 11740.765184696087, 11820.172587919107, 12098.516059357527, 12339.876601233873, 12360.381980901098, 12382.257064576153], "value": 8179.606096286174, "unit": "score"}], "name": "dromaeo_css", "value": 7656.47287761566, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 112.0, 110.0, 111.0, 113.0, 110.0, 112.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 117.0, 147.0, 120.0, 117.0, 121.0, 117.0, 145.0, 121.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 161.0, 159.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 124.0, 75.0, 75.0, 74.0, 85.0, 109.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 107.0, 80.0, 81.0, 81.0, 112.0, 81.0, 81.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 52.0, 49.0, 48.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 57.0, 57.0, 60.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 73.0, 73.0, 80.0, 74.0, 79.0, 76.0, 80.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 123.0, 124.0, 118.0, 132.0, 119.0, 118.0, 161.0, 133.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 155.0, 151.0, 151.0, 151.0, 156.0, 152.0, 155.0, 156.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 63.0, 61.0, 63.0, 61.0, 62.0, 64.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1456.9999999999998, "alertThreshold": 2.0}]} 23:44:41 INFO - Return code: 0 23:44:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:41 INFO - # TBPL SUCCESS # 23:44:41 INFO - Running post-action listener: _resource_record_post_action 23:44:41 INFO - [mozharness: 2016-10-22 06:44:41.523092Z] Finished run-tests step (success) 23:44:41 INFO - Running post-run listener: _resource_record_post_run 23:44:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 2134016; Write bytes: 357896192; Read time: 584; Write time: 244272 23:44:41 INFO - TinderboxPrint: CPU usage
12.9% 23:44:41 INFO - TinderboxPrint: I/O read bytes / time
2,134,016 / 584 23:44:41 INFO - TinderboxPrint: I/O write bytes / time
357,896,192 / 244,272 23:44:41 INFO - TinderboxPrint: CPU idle
8,257.7 (87.1%) 23:44:41 INFO - TinderboxPrint: CPU user
1,181.2 (12.5%) 23:44:41 INFO - TinderboxPrint: Swap in / out
0 / 0 23:44:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118792192; Read time: 0; Write time: 80824 23:44:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 239104000; Read time: 16; Write time: 163448 23:44:42 INFO - Running post-run listener: _upload_blobber_files 23:44:42 INFO - Blob upload gear active. 23:44:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:42 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 23:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:44:42 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:43 INFO - (blobuploader) - INFO - Done attempting. 23:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:46 INFO - (blobuploader) - INFO - Done attempting. 23:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:44:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:47 INFO - (blobuploader) - INFO - Done attempting. 23:44:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:47 INFO - Return code: 0 23:44:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5cf5b82deb3787de316d6c63112a1150beef699988eb1707c19fafc87578565233e0d9fae898242e9c5cf706af7bdf4fcfd436e994f4be363e667c177ca97dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b259396150949bd96471ad187021dc2209dfa6abb8dc36ac52484ac053ea16c3e66fcd9366a2170649881c50eb6de5a3d479815a605d751bf500f83472752a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69f03641354235c04b01196b19efea747d5b086405592855d0f74fdcc9c149e9429c8c2039f8e36fd8cfa2de996956e57df850abc632d23c20bd800ce2c0b9b5"} 23:44:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:47 INFO - Contents: 23:44:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5cf5b82deb3787de316d6c63112a1150beef699988eb1707c19fafc87578565233e0d9fae898242e9c5cf706af7bdf4fcfd436e994f4be363e667c177ca97dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b259396150949bd96471ad187021dc2209dfa6abb8dc36ac52484ac053ea16c3e66fcd9366a2170649881c50eb6de5a3d479815a605d751bf500f83472752a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69f03641354235c04b01196b19efea747d5b086405592855d0f74fdcc9c149e9429c8c2039f8e36fd8cfa2de996956e57df850abc632d23c20bd800ce2c0b9b5"} 23:44:47 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:47 INFO - Copying logs to upload dir... 23:44:47 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.945368 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-10-21 23:44:47.213112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 23:44:47.216543) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5cf5b82deb3787de316d6c63112a1150beef699988eb1707c19fafc87578565233e0d9fae898242e9c5cf706af7bdf4fcfd436e994f4be363e667c177ca97dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b259396150949bd96471ad187021dc2209dfa6abb8dc36ac52484ac053ea16c3e66fcd9366a2170649881c50eb6de5a3d479815a605d751bf500f83472752a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69f03641354235c04b01196b19efea747d5b086405592855d0f74fdcc9c149e9429c8c2039f8e36fd8cfa2de996956e57df850abc632d23c20bd800ce2c0b9b5"} build_url:https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011924 build_url: 'https://queue.taskcluster.net/v1/task/JSugurgqRz2Ra-szePUTGQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5cf5b82deb3787de316d6c63112a1150beef699988eb1707c19fafc87578565233e0d9fae898242e9c5cf706af7bdf4fcfd436e994f4be363e667c177ca97dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b259396150949bd96471ad187021dc2209dfa6abb8dc36ac52484ac053ea16c3e66fcd9366a2170649881c50eb6de5a3d479815a605d751bf500f83472752a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69f03641354235c04b01196b19efea747d5b086405592855d0f74fdcc9c149e9429c8c2039f8e36fd8cfa2de996956e57df850abc632d23c20bd800ce2c0b9b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 23:44:47.246634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:44:47.247395) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477114674.459801-1300289209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 23:44:47.328249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 23:44:47.328557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 23:44:47.328880) ========= ========= Total master_lag: 0.16 =========