builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1481547123.91 results: success (0) buildid: 20161212030206 builduid: b6c9c7597f5849d7bc7fa7e2a56b9bb5 revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:03.920012) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:03.920640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:03.920958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:03.936334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:03.936721) ========= 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=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-12 04:52:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-12-12 04:52:04 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:04.067397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:04.067747) ========= 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=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014533 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:04.117690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 04:52:04.118066) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --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=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-12 04:52:04,367 truncating revision to first 12 chars 2016-12-12 04:52:04,367 Setting DEBUG logging. 2016-12-12 04:52:04,367 attempt 1/10 2016-12-12 04:52:04,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42086c06f756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-12 04:52:05,536 unpacking tar archive at: mozilla-central-42086c06f756/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 04:52:05.595929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:05.596241) ========= script_repo_revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:05.596655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:05.596945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 04:52:05.607311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-12 04:52:05.607759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:05 INFO - MultiFileLogger online at 20161212 04:52:05 in /builds/slave/test 04:52:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:52:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:05 INFO - {'append_to_log': False, 04:52:05 INFO - 'base_work_dir': '/builds/slave/test', 04:52:05 INFO - 'blob_upload_branch': 'Firefox', 04:52:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:05 INFO - 'branch': 'Firefox', 04:52:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:05 INFO - 'config_files': ('talos/linux_config.py',), 04:52:05 INFO - 'default_actions': ('clobber', 04:52:05 INFO - 'read-buildbot-config', 04:52:05 INFO - 'download-and-extract', 04:52:05 INFO - 'populate-webroot', 04:52:05 INFO - 'create-virtualenv', 04:52:05 INFO - 'install', 04:52:05 INFO - 'run-tests'), 04:52:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:05 INFO - 'download_minidump_stackwalk': True, 04:52:05 INFO - 'download_symbols': 'ondemand', 04:52:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:05 INFO - 'installer_path': 'installer.exe', 04:52:05 INFO - 'log_level': 'info', 04:52:05 INFO - 'log_name': 'talos', 04:52:05 INFO - 'log_to_console': True, 04:52:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:05 INFO - 'opt_config_files': (), 04:52:05 INFO - 'pip_index': False, 04:52:05 INFO - 'sps_profile': False, 04:52:05 INFO - 'sps_profile_interval': 0, 04:52:05 INFO - 'suite': 'dromaeojs', 04:52:05 INFO - 'system_bits': '32', 04:52:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:05 INFO - 'title': 'talos-linux64-ix-017', 04:52:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:05 INFO - 'use_talos_json': True, 04:52:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:05 INFO - 'work_dir': 'build'} 04:52:05 INFO - [mozharness: 2016-12-12 12:52:05.956213Z] Running clobber step. 04:52:05 INFO - Running pre-action listener: _resource_record_pre_action 04:52:05 INFO - Running main action method: clobber 04:52:05 INFO - rmtree: /builds/slave/test/build 04:52:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:06 INFO - Running post-action listener: _resource_record_post_action 04:52:06 INFO - [mozharness: 2016-12-12 12:52:06.403653Z] Finished clobber step (success) 04:52:06 INFO - [mozharness: 2016-12-12 12:52:06.403752Z] Running read-buildbot-config step. 04:52:06 INFO - Running pre-action listener: _resource_record_pre_action 04:52:06 INFO - Running main action method: read_buildbot_config 04:52:06 INFO - Using buildbot properties: 04:52:06 INFO - { 04:52:06 INFO - "project": "", 04:52:06 INFO - "product": "firefox", 04:52:06 INFO - "script_repo_revision": "production", 04:52:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:52:06 INFO - "repository": "", 04:52:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:52:06 INFO - "buildid": "20161212030206", 04:52:06 INFO - "stage_platform": "linux64-pgo", 04:52:06 INFO - "basedir": "/builds/slave/test", 04:52:06 INFO - "nightly_build": "True", 04:52:06 INFO - "buildnumber": 126, 04:52:06 INFO - "slavename": "talos-linux64-ix-017", 04:52:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:52:06 INFO - "platform": "ubuntu64_hw", 04:52:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:52:06 INFO - "branch": "mozilla-central", 04:52:06 INFO - "repo_path": "mozilla-central", 04:52:06 INFO - "revision": "42086c06f756cda7fbc25a2e7c20a5711f7e5f26", 04:52:06 INFO - "pgo_build": "True", 04:52:06 INFO - "builduid": "b6c9c7597f5849d7bc7fa7e2a56b9bb5", 04:52:06 INFO - "slavebuilddir": "test" 04:52:06 INFO - } 04:52:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:52:06 INFO - Running post-action listener: _resource_record_post_action 04:52:06 INFO - [mozharness: 2016-12-12 12:52:06.406274Z] Finished read-buildbot-config step (success) 04:52:06 INFO - [mozharness: 2016-12-12 12:52:06.406362Z] Running download-and-extract step. 04:52:06 INFO - Running pre-action listener: _resource_record_pre_action 04:52:06 INFO - Running main action method: download_and_extract 04:52:06 INFO - mkdir: /builds/slave/test/build/tests 04:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:06 INFO - trying https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:52:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:52:06 INFO - Downloaded 1361 bytes. 04:52:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:52:06 INFO - Using the following test package requirements: 04:52:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:52:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'jsshell-linux-x86_64.zip'], 04:52:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:52:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:52:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:52:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:52:07 INFO - Expected file size: 21786362 04:52:07 INFO - Obtained file size: 21786362 04:52:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:52:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:52:12 INFO - Expected file size: 21786362 04:52:12 INFO - Obtained file size: 21786362 04:52:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:52:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:52:17 INFO - Expected file size: 14409734 04:52:17 INFO - Obtained file size: 14409734 04:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:18 INFO - trying https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:52:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:52:19 INFO - Downloaded 59871987 bytes. 04:52:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:52:19 INFO - mkdir: /builds/slave/test/properties 04:52:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:19 INFO - Contents: 04:52:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:52:19 INFO - Running post-action listener: _resource_record_post_action 04:52:19 INFO - Running post-action listener: set_extra_try_arguments 04:52:19 INFO - [mozharness: 2016-12-12 12:52:19.968034Z] Finished download-and-extract step (success) 04:52:19 INFO - [mozharness: 2016-12-12 12:52:19.968258Z] Running populate-webroot step. 04:52:19 INFO - Running pre-action listener: _resource_record_pre_action 04:52:19 INFO - Running main action method: populate_webroot 04:52:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:19 INFO - '--tppagecycles', 04:52:19 INFO - '7'], 04:52:19 INFO - 'tests': ['tsvgm']}}, 04:52:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['damp', 'tps']}, 04:52:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'tests': ['damp', 'tps']}, 04:52:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['dromaeo_dom']}, 04:52:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['basic_compositor_video']}, 04:52:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:52:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['a11yr', 04:52:19 INFO - 'ts_paint', 04:52:19 INFO - 'tpaint', 04:52:19 INFO - 'sessionrestore', 04:52:19 INFO - 'sessionrestore_no_auto_restore', 04:52:19 INFO - 'tabpaint']}, 04:52:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['tsvgx', 04:52:19 INFO - 'tsvgr_opacity', 04:52:19 INFO - 'tart', 04:52:19 INFO - 'tscrollx', 04:52:19 INFO - 'cart', 04:52:19 INFO - 'tsvg_static']}, 04:52:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:19 INFO - 'tsvgr_opacity', 04:52:19 INFO - 'tart', 04:52:19 INFO - 'tscrollx', 04:52:19 INFO - 'cart', 04:52:19 INFO - 'tsvg_static']}, 04:52:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'talos_options': ['--disable-e10s'], 04:52:19 INFO - 'tests': ['tp5o']}, 04:52:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'talos_options': ['--disable-e10s', 04:52:19 INFO - '--xperf_path', 04:52:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:19 INFO - 'tests': ['tp5n']}, 04:52:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:19 INFO - 'talos_options': ['--xperf_path', 04:52:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:19 INFO - 'tests': ['tp5n']}}, 04:52:19 INFO - 'talos.zip': {'path': '', 04:52:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:19 INFO - Running post-action listener: _resource_record_post_action 04:52:19 INFO - [mozharness: 2016-12-12 12:52:19.989688Z] Finished populate-webroot step (success) 04:52:19 INFO - [mozharness: 2016-12-12 12:52:19.989777Z] Running create-virtualenv step. 04:52:19 INFO - Running pre-action listener: _resource_record_pre_action 04:52:19 INFO - Running main action method: create_virtualenv 04:52:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:19 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 04:52:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:20 INFO - Using real prefix '/usr' 04:52:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:22 INFO - Installing pip.................done. 04:52:22 INFO - Return code: 0 04:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:22 INFO - Reading from file tmpfile_stdout 04:52:22 INFO - Output received: 04:52:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:52:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:22 INFO - Using env: {'DISPLAY': ':0', 04:52:22 INFO - 'HOME': '/home/cltbld', 04:52:22 INFO - 'LANG': 'en_US.UTF-8', 04:52:22 INFO - 'LANGUAGE': 'en_US:en', 04:52:22 INFO - 'LOGNAME': 'cltbld', 04:52:22 INFO - 'MAIL': '/var/mail/cltbld', 04:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:22 INFO - 'MOZ_NO_REMOTE': '1', 04:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:22 INFO - 'NO_EM_RESTART': '1', 04:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:22 INFO - 'PWD': '/builds/slave/test', 04:52:22 INFO - 'SHELL': '/bin/bash', 04:52:22 INFO - 'SHLVL': '1', 04:52:22 INFO - 'TERM': 'linux', 04:52:22 INFO - 'TMOUT': '86400', 04:52:22 INFO - 'USER': 'cltbld', 04:52:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:22 INFO - '_': '/tools/buildbot/bin/python'} 04:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:22 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 04:52:22 INFO - Cleaning up... 04:52:22 INFO - Return code: 0 04:52:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:52:22 INFO - Using env: {'DISPLAY': ':0', 04:52:22 INFO - 'HOME': '/home/cltbld', 04:52:22 INFO - 'LANG': 'en_US.UTF-8', 04:52:23 INFO - 'LANGUAGE': 'en_US:en', 04:52:23 INFO - 'LOGNAME': 'cltbld', 04:52:23 INFO - 'MAIL': '/var/mail/cltbld', 04:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:23 INFO - 'MOZ_NO_REMOTE': '1', 04:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:23 INFO - 'NO_EM_RESTART': '1', 04:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:23 INFO - 'PWD': '/builds/slave/test', 04:52:23 INFO - 'SHELL': '/bin/bash', 04:52:23 INFO - 'SHLVL': '1', 04:52:23 INFO - 'TERM': 'linux', 04:52:23 INFO - 'TMOUT': '86400', 04:52:23 INFO - 'USER': 'cltbld', 04:52:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:23 INFO - '_': '/tools/buildbot/bin/python'} 04:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:23 INFO - Downloading/unpacking psutil>=3.1.1 04:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:25 INFO - Installing collected packages: psutil 04:52:25 INFO - Running setup.py install for psutil 04:52:25 INFO - building 'psutil._psutil_linux' extension 04:52:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:52:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:52:25 INFO - building 'psutil._psutil_posix' extension 04:52:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:52:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:25 INFO - Successfully installed psutil 04:52:25 INFO - Cleaning up... 04:52:25 INFO - Return code: 0 04:52:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:52:25 INFO - Using env: {'DISPLAY': ':0', 04:52:25 INFO - 'HOME': '/home/cltbld', 04:52:25 INFO - 'LANG': 'en_US.UTF-8', 04:52:25 INFO - 'LANGUAGE': 'en_US:en', 04:52:25 INFO - 'LOGNAME': 'cltbld', 04:52:25 INFO - 'MAIL': '/var/mail/cltbld', 04:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:25 INFO - 'MOZ_NO_REMOTE': '1', 04:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:25 INFO - 'NO_EM_RESTART': '1', 04:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:25 INFO - 'PWD': '/builds/slave/test', 04:52:25 INFO - 'SHELL': '/bin/bash', 04:52:25 INFO - 'SHLVL': '1', 04:52:25 INFO - 'TERM': 'linux', 04:52:25 INFO - 'TMOUT': '86400', 04:52:25 INFO - 'USER': 'cltbld', 04:52:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:25 INFO - '_': '/tools/buildbot/bin/python'} 04:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:28 INFO - Installing collected packages: mozsystemmonitor 04:52:28 INFO - Running setup.py install for mozsystemmonitor 04:52:28 INFO - Successfully installed mozsystemmonitor 04:52:28 INFO - Cleaning up... 04:52:28 INFO - Return code: 0 04:52:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:52:28 INFO - Using env: {'DISPLAY': ':0', 04:52:28 INFO - 'HOME': '/home/cltbld', 04:52:28 INFO - 'LANG': 'en_US.UTF-8', 04:52:28 INFO - 'LANGUAGE': 'en_US:en', 04:52:28 INFO - 'LOGNAME': 'cltbld', 04:52:28 INFO - 'MAIL': '/var/mail/cltbld', 04:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:28 INFO - 'MOZ_NO_REMOTE': '1', 04:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:28 INFO - 'NO_EM_RESTART': '1', 04:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:28 INFO - 'PWD': '/builds/slave/test', 04:52:28 INFO - 'SHELL': '/bin/bash', 04:52:28 INFO - 'SHLVL': '1', 04:52:28 INFO - 'TERM': 'linux', 04:52:28 INFO - 'TMOUT': '86400', 04:52:28 INFO - 'USER': 'cltbld', 04:52:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:28 INFO - '_': '/tools/buildbot/bin/python'} 04:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:30 INFO - warning: no files found matching '*.txt' 04:52:30 INFO - no previously-included directories found matching 'build' 04:52:30 INFO - no previously-included directories found matching 'dist' 04:52:30 INFO - no previously-included directories found matching '.git*' 04:52:30 INFO - Installing collected packages: jsonschema, functools32 04:52:30 INFO - Running setup.py install for functools32 04:52:30 INFO - warning: no files found matching '*.txt' 04:52:30 INFO - no previously-included directories found matching 'build' 04:52:30 INFO - no previously-included directories found matching 'dist' 04:52:30 INFO - no previously-included directories found matching '.git*' 04:52:30 INFO - Successfully installed jsonschema functools32 04:52:30 INFO - Cleaning up... 04:52:30 INFO - Return code: 0 04:52:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:52:30 INFO - Using env: {'DISPLAY': ':0', 04:52:30 INFO - 'HOME': '/home/cltbld', 04:52:30 INFO - 'LANG': 'en_US.UTF-8', 04:52:30 INFO - 'LANGUAGE': 'en_US:en', 04:52:30 INFO - 'LOGNAME': 'cltbld', 04:52:30 INFO - 'MAIL': '/var/mail/cltbld', 04:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:30 INFO - 'MOZ_NO_REMOTE': '1', 04:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:30 INFO - 'NO_EM_RESTART': '1', 04:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:30 INFO - 'PWD': '/builds/slave/test', 04:52:30 INFO - 'SHELL': '/bin/bash', 04:52:30 INFO - 'SHLVL': '1', 04:52:30 INFO - 'TERM': 'linux', 04:52:30 INFO - 'TMOUT': '86400', 04:52:30 INFO - 'USER': 'cltbld', 04:52:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:30 INFO - '_': '/tools/buildbot/bin/python'} 04:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:52:31 INFO - Cleaning up... 04:52:31 INFO - Return code: 0 04:52:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:31 INFO - Using env: {'DISPLAY': ':0', 04:52:31 INFO - 'HOME': '/home/cltbld', 04:52:31 INFO - 'LANG': 'en_US.UTF-8', 04:52:31 INFO - 'LANGUAGE': 'en_US:en', 04:52:31 INFO - 'LOGNAME': 'cltbld', 04:52:31 INFO - 'MAIL': '/var/mail/cltbld', 04:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:31 INFO - 'MOZ_NO_REMOTE': '1', 04:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:31 INFO - 'NO_EM_RESTART': '1', 04:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:31 INFO - 'PWD': '/builds/slave/test', 04:52:31 INFO - 'SHELL': '/bin/bash', 04:52:31 INFO - 'SHLVL': '1', 04:52:31 INFO - 'TERM': 'linux', 04:52:31 INFO - 'TMOUT': '86400', 04:52:31 INFO - 'USER': 'cltbld', 04:52:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:31 INFO - '_': '/tools/buildbot/bin/python'} 04:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:34 INFO - Downloading docopt-0.6.1.tar.gz 04:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:34 INFO - Running setup.py install for blobuploader 04:52:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:34 INFO - Running setup.py install for requests 04:52:34 INFO - Running setup.py install for docopt 04:52:34 INFO - Successfully installed blobuploader requests docopt 04:52:34 INFO - Cleaning up... 04:52:34 INFO - Return code: 0 04:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:34 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')]} 04:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:34 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')]} 04:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:34 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 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:34 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 04:52:34 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 04:52:34 INFO - Using env: {'DISPLAY': ':0', 04:52:34 INFO - 'HOME': '/home/cltbld', 04:52:34 INFO - 'LANG': 'en_US.UTF-8', 04:52:34 INFO - 'LANGUAGE': 'en_US:en', 04:52:34 INFO - 'LOGNAME': 'cltbld', 04:52:34 INFO - 'MAIL': '/var/mail/cltbld', 04:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:34 INFO - 'MOZ_NO_REMOTE': '1', 04:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:34 INFO - 'NO_EM_RESTART': '1', 04:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:34 INFO - 'PWD': '/builds/slave/test', 04:52:34 INFO - 'SHELL': '/bin/bash', 04:52:34 INFO - 'SHLVL': '1', 04:52:34 INFO - 'TERM': 'linux', 04:52:34 INFO - 'TMOUT': '86400', 04:52:34 INFO - 'USER': 'cltbld', 04:52:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:34 INFO - '_': '/tools/buildbot/bin/python'} 04:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:34 INFO - Running setup.py (path:/tmp/pip-bu5HXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:35 INFO - Running setup.py (path:/tmp/pip-CX1zjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:35 INFO - Running setup.py (path:/tmp/pip-DqETOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:35 INFO - Running setup.py (path:/tmp/pip-XAFSri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:35 INFO - Running setup.py (path:/tmp/pip-mfECeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:35 INFO - Running setup.py (path:/tmp/pip-UJp47m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:35 INFO - Running setup.py (path:/tmp/pip-orreki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:35 INFO - Running setup.py (path:/tmp/pip-sfFG2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:35 INFO - Running setup.py (path:/tmp/pip-cxS5Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:35 INFO - Running setup.py (path:/tmp/pip-M2T5Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:35 INFO - Running setup.py (path:/tmp/pip-knEWFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:35 INFO - Running setup.py (path:/tmp/pip-0YcTjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:35 INFO - Running setup.py (path:/tmp/pip-rw4m2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:35 INFO - Running setup.py (path:/tmp/pip-RsCPee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:35 INFO - Running setup.py (path:/tmp/pip-J7VMQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:36 INFO - Running setup.py (path:/tmp/pip-RIKmuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:36 INFO - Running setup.py (path:/tmp/pip-F0YOWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:36 INFO - Running setup.py install for manifestparser 04:52:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Running setup.py install for mozcrash 04:52:36 INFO - Running setup.py install for mozdebug 04:52:36 INFO - Running setup.py install for mozdevice 04:52:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Running setup.py install for mozfile 04:52:36 INFO - Running setup.py install for mozhttpd 04:52:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Running setup.py install for mozinfo 04:52:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Running setup.py install for mozInstall 04:52:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Running setup.py install for mozleak 04:52:37 INFO - Running setup.py install for mozlog 04:52:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Running setup.py install for moznetwork 04:52:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Running setup.py install for mozprocess 04:52:37 INFO - Running setup.py install for mozprofile 04:52:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Running setup.py install for mozrunner 04:52:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Running setup.py install for mozscreenshot 04:52:37 INFO - Running setup.py install for moztest 04:52:37 INFO - Running setup.py install for mozversion 04:52:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:37 INFO - Cleaning up... 04:52:38 INFO - Return code: 0 04:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:38 INFO - Using env: {'DISPLAY': ':0', 04:52:38 INFO - 'HOME': '/home/cltbld', 04:52:38 INFO - 'LANG': 'en_US.UTF-8', 04:52:38 INFO - 'LANGUAGE': 'en_US:en', 04:52:38 INFO - 'LOGNAME': 'cltbld', 04:52:38 INFO - 'MAIL': '/var/mail/cltbld', 04:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:38 INFO - 'MOZ_NO_REMOTE': '1', 04:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:38 INFO - 'NO_EM_RESTART': '1', 04:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:38 INFO - 'PWD': '/builds/slave/test', 04:52:38 INFO - 'SHELL': '/bin/bash', 04:52:38 INFO - 'SHLVL': '1', 04:52:38 INFO - 'TERM': 'linux', 04:52:38 INFO - 'TMOUT': '86400', 04:52:38 INFO - 'USER': 'cltbld', 04:52:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:38 INFO - '_': '/tools/buildbot/bin/python'} 04:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:38 INFO - Running setup.py (path:/tmp/pip-rxIJTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:38 INFO - Running setup.py (path:/tmp/pip-GaCszC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:38 INFO - Running setup.py (path:/tmp/pip-1f7VzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:38 INFO - Running setup.py (path:/tmp/pip-OzTQ5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:38 INFO - Running setup.py (path:/tmp/pip-NzMnU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:38 INFO - Running setup.py (path:/tmp/pip-om8gCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:38 INFO - Running setup.py (path:/tmp/pip-foOcbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:38 INFO - Running setup.py (path:/tmp/pip-9eo0r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:38 INFO - Running setup.py (path:/tmp/pip-UJ8FA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:38 INFO - Running setup.py (path:/tmp/pip-vm5m3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:38 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)) 04:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:38 INFO - Running setup.py (path:/tmp/pip-0jCMZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:39 INFO - Running setup.py (path:/tmp/pip-4jaSKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:39 INFO - Running setup.py (path:/tmp/pip-ixHYYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:39 INFO - Running setup.py (path:/tmp/pip-KGSLgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:39 INFO - Running setup.py (path:/tmp/pip-AtJu69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:39 INFO - Running setup.py (path:/tmp/pip-QIKXqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:39 INFO - Running setup.py (path:/tmp/pip-ilsStU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:41 INFO - Downloading blessings-1.6.tar.gz 04:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:41 INFO - Installing collected packages: blessings 04:52:41 INFO - Running setup.py install for blessings 04:52:41 INFO - Successfully installed blessings 04:52:41 INFO - Cleaning up... 04:52:41 INFO - Return code: 0 04:52:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:41 INFO - Reading from file tmpfile_stdout 04:52:41 INFO - Current package versions: 04:52:41 INFO - argparse == 1.2.1 04:52:41 INFO - blessings == 1.6 04:52:41 INFO - blobuploader == 1.2.4 04:52:41 INFO - docopt == 0.6.1 04:52:41 INFO - functools32 == 3.2.3-2 04:52:41 INFO - jsonschema == 2.5.1 04:52:41 INFO - manifestparser == 1.1 04:52:41 INFO - mozInstall == 1.12 04:52:41 INFO - mozcrash == 1.0 04:52:41 INFO - mozdebug == 0.1 04:52:41 INFO - mozdevice == 0.49 04:52:41 INFO - mozfile == 1.2 04:52:41 INFO - mozhttpd == 0.7 04:52:41 INFO - mozinfo == 0.9 04:52:41 INFO - mozleak == 0.1 04:52:41 INFO - mozlog == 3.4 04:52:41 INFO - moznetwork == 0.27 04:52:41 INFO - mozprocess == 0.23 04:52:41 INFO - mozprofile == 0.28 04:52:41 INFO - mozrunner == 6.13 04:52:41 INFO - mozscreenshot == 0.1 04:52:41 INFO - mozsystemmonitor == 0.3 04:52:41 INFO - moztest == 0.7 04:52:41 INFO - mozversion == 1.4 04:52:41 INFO - psutil == 3.1.1 04:52:41 INFO - requests == 1.2.3 04:52:41 INFO - wsgiref == 0.1.2 04:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:41 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 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:41 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 04:52:41 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 04:52:41 INFO - Using env: {'DISPLAY': ':0', 04:52:41 INFO - 'HOME': '/home/cltbld', 04:52:41 INFO - 'LANG': 'en_US.UTF-8', 04:52:41 INFO - 'LANGUAGE': 'en_US:en', 04:52:41 INFO - 'LOGNAME': 'cltbld', 04:52:41 INFO - 'MAIL': '/var/mail/cltbld', 04:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:41 INFO - 'MOZ_NO_REMOTE': '1', 04:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:41 INFO - 'NO_EM_RESTART': '1', 04:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:41 INFO - 'PWD': '/builds/slave/test', 04:52:41 INFO - 'SHELL': '/bin/bash', 04:52:41 INFO - 'SHLVL': '1', 04:52:41 INFO - 'TERM': 'linux', 04:52:41 INFO - 'TMOUT': '86400', 04:52:41 INFO - 'USER': 'cltbld', 04:52:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:41 INFO - '_': '/tools/buildbot/bin/python'} 04:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:42 INFO - Cleaning up... 04:52:42 INFO - Return code: 0 04:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d59cbbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1157a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f5120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, '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': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', '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 04:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:42 INFO - Using env: {'DISPLAY': ':0', 04:52:42 INFO - 'HOME': '/home/cltbld', 04:52:42 INFO - 'LANG': 'en_US.UTF-8', 04:52:42 INFO - 'LANGUAGE': 'en_US:en', 04:52:42 INFO - 'LOGNAME': 'cltbld', 04:52:42 INFO - 'MAIL': '/var/mail/cltbld', 04:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:42 INFO - 'MOZ_NO_REMOTE': '1', 04:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:42 INFO - 'NO_EM_RESTART': '1', 04:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:42 INFO - 'PWD': '/builds/slave/test', 04:52:42 INFO - 'SHELL': '/bin/bash', 04:52:42 INFO - 'SHLVL': '1', 04:52:42 INFO - 'TERM': 'linux', 04:52:42 INFO - 'TMOUT': '86400', 04:52:42 INFO - 'USER': 'cltbld', 04:52:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:42 INFO - '_': '/tools/buildbot/bin/python'} 04:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:52:42 INFO - Cleaning up... 04:52:42 INFO - Return code: 0 04:52:42 INFO - Running post-action listener: _resource_record_post_action 04:52:42 INFO - Running post-action listener: _start_resource_monitoring 04:52:42 INFO - Starting resource monitoring. 04:52:42 INFO - [mozharness: 2016-12-12 12:52:42.425978Z] Finished create-virtualenv step (success) 04:52:42 INFO - [mozharness: 2016-12-12 12:52:42.426490Z] Running install step. 04:52:42 INFO - Running pre-action listener: _resource_record_pre_action 04:52:42 INFO - Running main action method: install 04:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:42 INFO - Reading from file tmpfile_stdout 04:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:42 INFO - Reading from file tmpfile_stdout 04:52:42 INFO - Output received: 04:52:42 INFO - Usage: mozinstall [options] installer 04:52:42 INFO - Options: 04:52:42 INFO - -h, --help show this help message and exit 04:52:42 INFO - -d DEST, --destination=DEST 04:52:42 INFO - Directory to install application into. [default: 04:52:42 INFO - "/builds/slave/test"] 04:52:42 INFO - --app=APP Application being installed. [default: firefox] 04:52:42 INFO - mkdir: /builds/slave/test/build/application 04:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:52:59 INFO - Reading from file tmpfile_stdout 04:52:59 INFO - Output received: 04:52:59 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:59 INFO - Running post-action listener: _resource_record_post_action 04:52:59 INFO - [mozharness: 2016-12-12 12:52:59.701750Z] Finished install step (success) 04:52:59 INFO - [mozharness: 2016-12-12 12:52:59.701990Z] Running run-tests step. 04:52:59 INFO - Running pre-action listener: _resource_record_pre_action 04:52:59 INFO - Running main action method: run_tests 04:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:59 INFO - Python 2.7.3 04:52:59 INFO - Return code: 0 04:52:59 INFO - grabbing minidump binary from tooltool 04:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1385f20>, '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 0x12f2c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:52:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:52:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:59 INFO - Return code: 0 04:52:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 04:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 04:52:59 INFO - Using env: {'DISPLAY': ':0', 04:52:59 INFO - 'HOME': '/home/cltbld', 04:52:59 INFO - 'LANG': 'en_US.UTF-8', 04:52:59 INFO - 'LANGUAGE': 'en_US:en', 04:52:59 INFO - 'LOGNAME': 'cltbld', 04:52:59 INFO - 'MAIL': '/var/mail/cltbld', 04:52:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:59 INFO - 'MOZ_NO_REMOTE': '1', 04:52:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:59 INFO - 'NO_EM_RESTART': '1', 04:52:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:59 INFO - 'PWD': '/builds/slave/test', 04:52:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:59 INFO - 'SHELL': '/bin/bash', 04:52:59 INFO - 'SHLVL': '1', 04:52:59 INFO - 'TERM': 'linux', 04:52:59 INFO - 'TMOUT': '86400', 04:52:59 INFO - 'USER': 'cltbld', 04:52:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265', 04:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:59 INFO - '_': '/tools/buildbot/bin/python'} 04:52:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 04:52:59 INFO - mozversion application_buildid: 20161212030206 04:52:59 INFO - mozversion application_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 04:52:59 INFO - mozversion application_display_name: Nightly 04:52:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:59 INFO - mozversion application_name: Firefox 04:52:59 INFO - mozversion application_remotingname: firefox 04:52:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:52:59 INFO - mozversion application_vendor: Mozilla 04:52:59 INFO - mozversion application_version: 53.0a1 04:52:59 INFO - mozversion platform_buildid: 20161212030206 04:52:59 INFO - mozversion platform_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 04:52:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:52:59 INFO - mozversion platform_version: 53.0a1 04:52:59 INFO - using testdate: 1481547179 04:52:59 INFO - actual date: 1481547179 04:52:59 INFO - starting webserver on 'localhost:39229' 04:52:59 INFO - SUITE-START | Running 2 tests 04:52:59 INFO - TEST-START | dromaeo_css 04:52:59 INFO - operating with platform_type : linux_ 04:52:59 INFO - Initialising browser for dromaeo_css test... 04:52:59 INFO - TEST-INFO | started process 7294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOkoip/profile http://localhost:39229/getInfo.html) 04:53:03 INFO - PROCESS | 7294 | __metrics Screen width/height:1600/1200 04:53:03 INFO - PROCESS | 7294 | colorDepth:24 04:53:03 INFO - PROCESS | 7294 | Browser inner width/height: 1024/697 04:53:03 INFO - PROCESS | 7294 | __metrics 04:53:04 INFO - PROCESS | 7294 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:04 INFO - PROCESS | 7294 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:05 INFO - PROCESS | 7294 | console.error: PushService: 04:53:05 INFO - PROCESS | 7294 | stateChangeProcessEnqueue: Error transitioning state 04:53:05 INFO - PROCESS | 7294 | UnknownError 04:53:05 INFO - TEST-INFO | 7294: exit 0 04:53:05 INFO - Browser initialized. 04:53:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:05 INFO - TEST-INFO | started process 7380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOkoip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:17 INFO - PROCESS | 7380 | RSS: Main: 172421120 04:53:17 INFO - PROCESS | 7380 | 04:54:09 INFO - PROCESS | 7380 | 1481547249434 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] 04:56:19 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39229/tests/dromaeo/cssquery-ext.html) 04:56:21 INFO - PROCESS | 7380 | RSS: Main: 338132992 04:56:21 INFO - PROCESS | 7380 | 04:59:24 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-ext.html (next: http://localhost:39229/tests/dromaeo/cssquery-jquery.html) 04:59:24 INFO - PROCESS | 7380 | RSS: Main: 278745088 04:59:24 INFO - PROCESS | 7380 | 05:02:27 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39229/tests/dromaeo/cssquery-mootools.html) 05:02:27 INFO - PROCESS | 7380 | RSS: Main: 284405760 05:02:27 INFO - PROCESS | 7380 | 05:05:29 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39229/tests/dromaeo/cssquery-prototype.html) 05:05:30 INFO - PROCESS | 7380 | RSS: Main: 223784960 05:05:30 INFO - PROCESS | 7380 | 05:08:33 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39229/tests/dromaeo/cssquery-yui.html) 05:08:33 INFO - PROCESS | 7380 | RSS: Main: 226111488 05:08:33 INFO - PROCESS | 7380 | 05:11:36 INFO - PROCESS | 7380 | Cycle 1(1): loaded http://localhost:39229/tests/dromaeo/cssquery-yui.html (next: http://localhost:39229/tests/dromaeo/cssquery-dojo.html) 05:11:37 INFO - PROCESS | 7380 | RSS: Main: 316432384 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | __start_tp_report 05:11:37 INFO - PROCESS | 7380 | _x_x_mozilla_page_load 05:11:37 INFO - PROCESS | 7380 | _x_x_mozilla_page_load_details 05:11:37 INFO - PROCESS | 7380 | |i|pagename|runs| 05:11:37 INFO - PROCESS | 7380 | |0;dojo.html;3155.7159855613;3177.7457803375733;3195.089399521137;3209;3227.548143259944;5043.5965122790185;5083.5424811767025;5106.77019534121;5206.713630750312;5210.270562121302;5152.871178220546;5170.069387510247;5222.321098257221;5274.894502109955;5367.436419175979;4707.152712511746;4762.0475904819;4792.90414191716;4838.129136755382;4845.709257444547;4727.243641017438;4831.879203019935;4842.346283251769;4850.684705494149;4880.755962201875;4854.466008739036;4878.146324393235;4882.511748825124;4912.975435122819;4918.852434426973;4639.559241872017;4673.742944138071;4679.60223381013;4817.349657796188;4868.683535570177;4646.117237724855;4675.88310292242;4693.413323334583;4713.670043096985;4763.214069678499;5082.898342033139;5122.436531981479;5142.588592912558;5147.047796157723;5198.6880787152895;5363.597730170253;5479.698616576086;5482.533984611313;5482.753276102585;5484.369297530795;5395.271638328853;5430.511253987121;5469;5474.562035037187;5586.720663966786;5212.270282160501;5214.0875346814155;5215.400228973716;5219.686818790847;5219.791208351661;5660.85847853807;5663.235463212496;5663.292088488939;5666.824632728922;5724.742386592613;5314.468553144655;5343.465653434625;5365.141577347606;5383.892322153535;5400.189971504227;5457.045017121988;5484.177373393943;5491.36849262332;5504.889902201933;5548.639338442988;5436.891262174734;5484.067708489566;5486.31421072366;5492.80775172867;5533;5376.220448035091;5425.077736784756;5429.484199001088;5505.724713764296;5512.062949298629;4280.91438171241;4310.396544483775;4319.049809042006;4332.783360831946;4364.9960509083085;3917.216556688674;3921.0197450637343;3926.391409331558;3950.664193543581;3972;5226.529612334832;5231.058409486329;5233.215017747369;5234.7644356004075;5234.816781412632;5354.277172581652;5398.055340315429;5525.944740552623;5529.060059789846;5532.861678458071;5208.739563021833;5250.606204534599;5254.65844720092;5260.13207820713;5299.12564426873;4797.160496913096;4806.44725856524;4807.591354734886;4811.27830825372;4842.975785121052;5522.22688823565;5578.44215578447;5601.075822489406;5723.7996670116345;5733.168690539848;5547.362053363915;5569.610127291051;5590.385057643574;5599.972000139973;5621.971890140523;5783.855403614775;5784.768609255751;5786.392428794916;5786.623869448473;5791.160281759206;5472.589555783412;5479.2602998594675;5480.808171713971;5487.75305111263;5488.121900495901;5377.247185394126;5384.030874442638;5494.835154945358;5495.368032676293;5530.391656917655;5451.781928722807;5455.536279416294;5455.672659640434;5459.39946605881;5494.36814766307;5362.65142765719;5393.7033463159905;5404.216388623706;5432.320959880015;5451.781928722807;5170.819021334235;5281;5316.6544174628525;5380.542653874308;5401.621886468067;5485.61600687964;5487.972560137174;5490.835274941758;5492.231087647812;5545.3622833374675;5169.612279079009;5197.506236907488;5199.66202196856;5267.57859371257;5360.142377219782 05:11:37 INFO - PROCESS | 7380 | |1;ext.html;541.0882662713328;555.3973938276969;570.0707846210676;571.6598623818829;578.884223155369;30733.69266307336;31319;38203.617963820354;40493.79753101238;40636.79681601588;42095.78952105243;42376;42417.57582424175;42488.57511424885;42588.574114258925;8442.451240669352;8635;8639.784005399884;8640.481571105754;8643.394962352639;7746.883796743054;7998.680052797881;9918.950405247964;10219.335743176707;10227.590896364136;10156.695299141038;10216.948915255412;10223.28437009406;10227.846582301234;10228.284020118595;10137.645182418617;10199.694009179737;10213.18294536439;10214.948925255401;10251.231157663206;9997;10071.34536255141;10083.697489075339;10090.19278457729;10091.848622270672;39157.608423915684;39395;39457.60542394597;39489.40765888514;39536.802315988236;3266.216108134031;3362.09223509651;3392.6098498672477;3425.047722798006;3854.8650797221962;29540;29586.082783443184;29803;30642.38715225705;30703.539446908315;4054.9391759123637;4129.587041295877;4134.536832247403;4303.784810759481;4320.740755554677;308544.4572777144;308683;309252;309542;310518;51391.48608513942;51602.22596661053;51784.74107629438;51823.22265166025;51840.22239666408;54037.459625403244;54144;54300.72849635727;54471;54570;13328.200307981358;13545.187288762705;13550.390232439564;13559.796603050961;13627.454901804014;10162.695119146438;10403.427811470441;11215.94392028051;11320.433978301053;11337.603183888525;14020.71958560823;14055;14123.364448599632;14741.705165896621;14998.925005374904;6069.696515174223;6361.713722882481;6400.487960963112;6410.839729006719;6458.160439142881;924.6440120553635;954.5704433005176;999.8200323941614;1097.5993762276712;1132.6262333429947;28206;29823.254418639706;30270.243243919078;30547.847260763552;30641.84679076635;1043.5408420295046;1046.3460337289193;1051.358671210561;1059.3220338983058;1078.4553800330782;15139.167345796088;15710.135942523042;15799.447019354267;16086.43697470583;16206.189690515426;467564.86527020537;469762;471401;471843;648098;45807.541924581;53537.73231133819;54858.45141548533;55238.447615524135;59020.40979590235;1299.707565797688;1301.557470460048;1303.1985329022773;1315.3949183375755;1319.399673148715;28878.278043048253;30559.54160687636;30568.235794104436;31002.534961975136;31297;46470;47000.7649961748;47035.764821175675;47101;47111;390411;392213;392926;393449;393743;37053.44419833759;37139;37405;37450.8127459361;38661.80669096637;42589.148217036105;43767;44428.55571444244;44474.888127797065;44602.77698611486;37003.25993480169;37446.2510749778;38164.61835381722;38741;39715.80142099386;37066.8146659265;37077;37268.44097338488;37998.86003419902;38991.805040974614;37615.62384376121;38519;38637;38770;38796.80601596974;31433.52849707302;33555.66444335526;33857.322853543286;34442.655573443946;34487.4826877602;25745.485090297716;25915.594348961098;25919.740802591732;26167.607485888107;26635.467290654466 05:11:37 INFO - PROCESS | 7380 | |2;jquery.html;365.09274452984346;373.60024773492364;382.8353807862618;386.69064748201436;399.3271337795814;14158.929205353972;18295.725564116532;19583.99999999998;19991.800081999176;20077.498062548442;16703;17671.381501647444;18002.189901454432;18101.28480727888;18143.637127257447;5491.725413729318;5649.576281778863;5695.259616249882;5702.344230413514;5703.9714801425935;4069.104796944682;4360.084382279725;4406.845760398387;5550.2507161533285;5663.4336566343245;6333.524985626096;6430.067640192169;6443.48452123829;6443.516736244777;6447.742090316405;6445.1943507061615;6448.226212854464;6774.356436138559;6970.93029069713;7031.683574239171;6601.6699165041555;6884.242733299333;6896.413804826596;6900.585964842076;6910.550814197061;23132.65301020486;23416;23688.170914017926;23792.286231413087;24405.38986525333;2230.5761905237955;2279.338991692407;2292.2435596253194;2303.0212159832004;3003.9249018774485;14030.43878244869;14775.408983640642;15115.622109447242;15359.385624575003;15735.606609834731;1935.3226370770258;1994.4814348269554;1996.9201231950703;2024.119508014004;2087.9791202087936;63110;83935.580322098;85319.99999999937;86388.56805715994;88757.55621221918;16492.752608710878;16636.6672666546;16861.409850655167;17099.914500427418;17164.485065447807;29440.700673878906;29451.410971780446;29533;29630.111096667133;29654.258643534085;8662.263707584925;8806.691765788166;8859.11408859109;9081.591328390106;9164.312676549285;7096.53872498286;7122.2521635228595;7205.171405288354;7344.926550734531;7372.48392612512;8317.41778075529;8462.069172391031;8477.067522572512;8497.36269779769;8681.826363472695;3127.827969461656;3246.9086557638516;3416.7949923004203;3472.5138480612736;3527.5414196154848;425.402309754795;441.4085125931268;464.92561190209403;817.1950628630794;913.1690161952591;10675.032972303303;11213.607523736793;11332.320060796214;11395.658130256106;11685.941570292263;434.8586709319421;441.77690266415254;448.4260147011765;452.4231604704029;467.7754677754697;6049.485793707584;6337.33457986914;9512.47681377517;10457;10601.098906592872;429395;432580;432857.52141153725;432928;443164;86458;86846.56576717076;87016.07742761254;87265;87481.56259218663;977.0571398600526;985.9950700246453;1026.9075783179549;1028.218553899042;1031.417249254169;15803.762943555626;16452.75320870164;16473.258703358617;16726.330946761995;16874;36398.454023189144;37106;37601.2479750398;39906.40140397838;42637.5736242646;51886;53178.73410632922;53957;54539;54708.72645636746;7605.581693006938;7775.14473407936;7922.168172341821;8000.51996880189;8037.557934313435;10265.74335641615;11530.250533715282;12080.697982550155;12255.448504817126;12935.223886566837;10515.474226288808;10796.460176991277;10942.671719848417;11057.834132487858;11073.889261107286;10664.733381665521;10677.305975111592;10697.732556686145;10797.24419290642;11253.21227514099;10645.308054976402;10709.464526773785;10851.565937362417;10910.509027093642;11238.325700458;7599.316061554487;7628.656710447932;7629.2370762923265;7850.293473587404;8121.634526446206;8297.103607090929;10796.622118225825;10877.945610271898;11062.280951738112;11145.72135696614 05:11:37 INFO - PROCESS | 7380 | |3;mootools.html;1275.1265383212506;1344.0457275334513;1357.5045108535385;1439.8344190418104;1670.2066518403751;6562.835929101769;7276.708931642735;7400.407967362611;7536.547807131576;7715.961420192905;7590.354819840307;7660.655270512826;7668.118166410864;7669.4247931405225;7672.578008209546;1825.3702472646914;2076.3148161106797;2115.164510018542;2117.3965419855344;2118.353902059871;1876.5308672831793;2078.5450184870574;2141.047233980871;2141.2612648636273;2149.978500215001;2062.608104460155;2090.0385822521657;2096.937091887246;2097.381272524601;2101.663733802592;2079.740032495938;2099.496120930981;2105.0316854247067;2105.157936825267;2109.3144727963395;2101.0965284927474;2119.268852245988;2122.416335507732;2125.90433430496;2126.1282874021576;7542.20806815282;7577.204393538709;7625.275598818103;7629.6948122075055;7641.656125474367;4640.280756482717;4763.857084287477;4765.404324459442;4765.523447655241;4765.714057156547;2879.6544414670375;2953.1288269960414;3028.333766571373;3121.5317702344605;3138.984305078483;863.818598094401;871.9651213951435;877.7147427086222;947.5404428852002;948.0945696859483;9938;9938.503074846229;9946.751331216778;9989.75025624358;10021.949890250575;3962.1481381503113;4211.347241177622;4254.149170165979;4257.425247591597;4286.678499112579;8412.242898139197;8416.663333466715;8472.364572657076;8504.957475212585;8509.446885952517;4682.508336624674;4700.6944548604915;4737.431508219036;4815.3499277597075;4819.7108173509705;3765.86819461323;4187.5184353799095;4400.823967041347;4409.382686423904;4411.051623900877;3510.7015903647966;3517.243792584555;3627.5828279748166;3636.1455058061333;3646.4894914711963;1165.091228841505;1178.3460179600404;1182.1901997131993;1188.085174415695;1189.9464524096436;779.6576630058398;780.42248735935;872.284726524244;918.8713580098791;932.8367535681228;4807.6394270429855;5088.847334579968;5149.124648809711;5335.093034184198;5337.599680024014;398.44218094667696;400.2675104558651;410.3106780608606;412.5523806669737;415.2484003952795;3439.105832483522;3557.324108419392;3569.1255642367787;3605.4231322988194;3648.689861361761;8761.868571971425;9202.355835091614;9207.309451791143;9207.63169473227;9219.815603687888;9154.450732956044;9158.679446219483;9162.267018638493;9173.862392063991;9175.22010629104;6901.309869013058;7012.439004879496;7159.642017899084;7243.4929554931705;7252.927470725225;4841.443234028132;4917.041176970456;4929.728864912321;4931.753412329297;5074.644774865724;8347.373946953881;8413.200745929127;8436.873446898178;8488.533130677872;8508.319334453105;7974.920250797418;8277.54473503939;8284;8518.61666225009;8525.658973640984;6099.11562823397;6270.184875966095;6732.360425759545;6822.863542729018;6866.176058872968;6927.203371612329;7070.080889484334;7124.715011399486;7307.26927307265;7315.890261645973;6464.8707025858275;6596.175478065242;6607.57050791697;6638.933610663831;6858.897116543156;6550.115734375799;6583.63789991555;6619.172603424572;6789.62657053847;6829.590224586541;5956.612820166675;6024.427679370453;6095;6096.390360964046;6111.511079113571;4232.830686772618;4287.506936702319;4289.892752681208;4302.677299202635;4405.911881762411;4172.4784401949755;4307.8276868924895;4336.609705126553;4345.456817897762;4383.342498625232 05:11:37 INFO - PROCESS | 7380 | |4;prototype.html;355.87544359474185;371.1519178676724;374.16747736286766;378.0869200879874;381.85298660015894;5082.745862706859;5153.896922061556;5173.5343819056325;5175.378954525458;5182.611304152189;5051.282563928264;5134.691918484894;5145.639805213627;5188.792448302072;5209.531142197211;4043.4743483347124;4116;4136.834526618946;4189.6229339359525;4192.287311157095;4189.497260328765;4193.51774545928;4209.810558524859;4221.514525829522;4242.9151416971645;4196.433481479991;4197.979010104945;4205.621494065534;4216.409702641633;4218.3250679891225;4061.532923713781;4193.161367726451;4195.937060944088;4213.367994800774;4219.346001369778;3765.604611515806;3788.29916465452;3788.3370410178386;3788.8484460621544;3792.4500947362753;5064.11378008847;5086.643934924557;5095.184770436712;5103.413107492649;5103.617228707824;4627.652926030528;4735.644826638016;4772.379590653193;4780.306855505967;4786.305985632064;5351.17056856184;5399.9730001350135;5413.945860541423;5434.049041417736;5435.483629055233;4087.509498860156;4113.568075352105;4146.295129827907;4188.350805625133;4200.411942328076;5545.805896793593;5689.459501347365;5705.6006079574445;5713.171785028792;5733.627314224604;4255.404243405926;4265.0830071534765;4276.2516559601945;4280.400743895857;4289.9571004289555;4322.286822674287;4333.158407676788;4333.5883091106925;4336.4145840311785;4343.3484977253665;4494.303382975644;4779.498152693986;4783.6651434399255;4792.664513484023;4828.493008234155;5075.746212689351;5468.398476167618;5471.917921231185;5489.066858634042;5514.80698175562;1453.2951518513512;1456.6940942402002;1457.358762144653;1463.2537405923056;1465.8566318271764;1006;1059.3008614314515;1059.6979860739807;1062.2882668612049;1068.6740544134113;5085.542301192911;5129.281900533928;5129.563987061067;5136.845894623092;5148.742562871841;5372.70450125239;5389.652586853286;5390.326209223847;5412.91880621791;5413.323334583177;4937.87655308613;5042.546170844642;5085.847424577269;5101.897962040738;5128;2869.297022229567;2870.8277503349864;2885.192146199068;2887.768978481716;2897.608822808936;5561.916571251434;5615.606907516516;5618.4662457066515;5632.549840819257;5639.464250896158;5345.81289654868;5409.24270602116;5489.725513724377;5490.917636235459;5511.283533140666;5590.301212348457;5600.263918185376;5620.550355971431;5643.548516118701;5673.404292549388;5225.425203227566;5348.7593058311695;5362.758675859518;5427.430119837518;5429.484199001246;5220.686758794484;5253.395859476209;5274.97362513185;5282;5305.389880163831;5527.281453411031;5531.557475402039;5537.473939975695;5549.445055494418;5562.332520097614;3697.59326474093;3930.8820735377985;3968.960310396859;3984.7210695251056;3995.7402768819934;5322.520973112283;5487.4483365235355;5543.861403464945;5558.276444542226;5582.441755824548;5332.840014799563;5438.782448702166;5472.127133254914;5484.369297530835;5494.615376923737;5464.781408743605;5479.424660410599;5484.2596249505805;5485.286912701324;5575.386707462095;5278.392984806796;5432.918506222489;5448.891022179455;5452.909418116314;5470.617056805985;5481.177823326533;5481.5340696041285;5489.505944465017;5500.394956554695;5514.270436134139;5231.241469986907;5347.946520534901;5355.169948657965;5428;5474.972625136849 05:11:37 INFO - PROCESS | 7380 | |5;yui.html;702.483674499243;736.2306389822635;741.232824027132;772.2972095393193;805.8670319397299;15157;15242.695146097085;15592.610184745387;15686.921565392156;16106.436274730388;13329.400176992034;13707.040507164502;14599;14772;14786.18675972821;773.2885745114494;792.2988155482411;793.1235984237421;793.1711361627114;793.175097898188;659.7624855052177;683.6240067962625;766.4634755671025;790.9169537198597;797.9640916158758;824.3281725393784;829.1252728371566;830.3440282177073;831.1771346367113;838.1534650003509;826.6569373709904;828.3373301358889;828.6809578312333;828.7016673997356;829.1625458287174;513.0431744795928;524.5410266017235;589.6403194051625;599.6342231238941;608.8325710429667;14765.483208087773;14797.186154761484;14815.851841481663;14818.33317500715;14919.925400373037;13551.119177253448;13577.796333055012;13654;13656.317184140753;13667.726645467035;12197.78412404125;12252.264864108181;12365.814512782315;12381.195222310522;12725.236485810789;4262.232798096342;4275.4228179195725;4278.914421711548;4454.510003899569;4481.596656300949;74402;75274.24725752727;76164.61917690432;76931.61534192349;78635;10880.455977201109;10940.617078402218;10956.890431095588;11017.779644407066;11540.480678369493;19870;20130.899345503178;20266.898665506873;20473.385798426072;20491.69262461064;7822.139564647884;7822.687092516236;7915.525068495908;7947.761567152879;8193.8361232775;4174.979125104355;4181.581841815855;4221.662267018631;4306.89232769177;4347.5652434756275;3071.5392691096513;3153.9684603153673;3165.2245199925705;3297.604287485517;3359.664033596621;575.2291928815407;576.766409604111;577.3793172339751;588.2529187931389;588.6409290332894;545.6207935484879;615.1633778061832;659.535027805396;683.5898460923406;699.7375984005997;8687.956560217284;8825.558722063999;8913.242374398249;9077.273818094536;9231.538423078819;550.9531689806331;553.0736017171222;632.3265722006049;690.5580428525748;712.149690294225;3994.980025099856;4159.729617574848;4262.65898728101;4372.628326592212;4405.66957478184;76341;77859;77968.61015694885;78700.21299787043;79326.60336698279;67526.64946701136;69277;69543.3045669547;69760.30239697538;69811.65094174497;60058.69970650206;60264.698676506334;60666.696666516385;60870.69564652148;61522;8061.2744852963515;8076.394270429859;8341;8394.664213431639;8462.365322600952;43093.784531077144;43423.13153736971;43753.12493750043;44055.33916991184;45884.31173532333;54801.45198547964;59835.102473463805;59981.70009149926;60607.696961514914;61575;11408.714782130513;11840.348780817138;11885.16803823724;12261.325627090595;12300.753984920073;12477.812832807334;12606.810897836724;12678.239305641691;12794.936025319814;13135.934320328719;13496.595102146952;13740.587782366545;13813.930930345285;14050.578482645536;14325;12943.611691649265;13335.933320333335;13651.522196723066;13878.306084695927;14624.780628290371;12571.68570785701;12807.359632018548;12999.1550549214;13287.468501260228;13672.589822305346;10705.250632455653;10723.410212438392;10836.241463097507;11156.49795759209;11441.313521188755;10871;11162.944185279022;11497.597584084517;11565.768684626428;11716.94141529287 05:11:37 INFO - PROCESS | 7380 | __end_tp_report 05:11:37 INFO - PROCESS | 7380 | __start_cc_report 05:11:37 INFO - PROCESS | 7380 | _x_x_mozilla_cycle_collect,1646 05:11:37 INFO - PROCESS | 7380 | __end_cc_report 05:11:37 INFO - PROCESS | 7380 | __startTimestamp1481548297203__endTimestamp 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | ------- Summary: start ------- 05:11:37 INFO - PROCESS | 7380 | Number of tests: 6 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#0] dojo.html Cycles:165 Average:5155.96 Median:5343.47 stddev:528.96 (9.9%) stddev-sans-first:506.78 05:11:37 INFO - PROCESS | 7380 | Values: 3155.7 3177.7 3195.1 3209.0 3227.5 5043.6 5083.5 5106.8 5206.7 5210.3 5152.9 5170.1 5222.3 5274.9 5367.4 4707.2 4762.0 4792.9 4838.1 4845.7 4727.2 4831.9 4842.3 4850.7 4880.8 4854.5 4878.1 4882.5 4913.0 4918.9 4639.6 4673.7 4679.6 4817.3 4868.7 4646.1 4675.9 4693.4 4713.7 4763.2 5082.9 5122.4 5142.6 5147.0 5198.7 5363.6 5479.7 5482.5 5482.8 5484.4 5395.3 5430.5 5469.0 5474.6 5586.7 5212.3 5214.1 5215.4 5219.7 5219.8 5660.9 5663.2 5663.3 5666.8 5724.7 5314.5 5343.5 5365.1 5383.9 5400.2 5457.0 5484.2 5491.4 5504.9 5548.6 5436.9 5484.1 5486.3 5492.8 5533.0 5376.2 5425.1 5429.5 5505.7 5512.1 4280.9 4310.4 4319.0 4332.8 4365.0 3917.2 3921.0 3926.4 3950.7 3972.0 5226.5 5231.1 5233.2 5234.8 5234.8 5354.3 5398.1 5525.9 5529.1 5532.9 5208.7 5250.6 5254.7 5260.1 5299.1 4797.2 4806.4 4807.6 4811.3 4843.0 5522.2 5578.4 5601.1 5723.8 5733.2 5547.4 5569.6 5590.4 5600.0 5622.0 5783.9 5784.8 5786.4 5786.6 5791.2 5472.6 5479.3 5480.8 5487.8 5488.1 5377.2 5384.0 5494.8 5495.4 5530.4 5451.8 5455.5 5455.7 5459.4 5494.4 5362.7 5393.7 5404.2 5432.3 5451.8 5170.8 5281.0 5316.7 5380.5 5401.6 5485.6 5488.0 5490.8 5492.2 5545.4 5169.6 5197.5 5199.7 5267.6 5360.1 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#1] ext.html Cycles:180 Average:55529.11 Median:37425.63 stddev:109410.74 (292.3%) stddev-sans-first:109639.77 05:11:37 INFO - PROCESS | 7380 | Values: 541.1 555.4 570.1 571.7 578.9 30733.7 31319.0 38203.6 40493.8 40636.8 42095.8 42376.0 42417.6 42488.6 42588.6 8442.5 8635.0 8639.8 8640.5 8643.4 7746.9 7998.7 9919.0 10219.3 10227.6 10156.7 10216.9 10223.3 10227.8 10228.3 10137.6 10199.7 10213.2 10214.9 10251.2 9997.0 10071.3 10083.7 10090.2 10091.8 39157.6 39395.0 39457.6 39489.4 39536.8 3266.2 3362.1 3392.6 3425.0 3854.9 29540.0 29586.1 29803.0 30642.4 30703.5 4054.9 4129.6 4134.5 4303.8 4320.7 308544.5 308683.0 309252.0 309542.0 310518.0 51391.5 51602.2 51784.7 51823.2 51840.2 54037.5 54144.0 54300.7 54471.0 54570.0 13328.2 13545.2 13550.4 13559.8 13627.5 10162.7 10403.4 11215.9 11320.4 11337.6 14020.7 14055.0 14123.4 14741.7 14998.9 6069.7 6361.7 6400.5 6410.8 6458.2 924.6 954.6 999.8 1097.6 1132.6 28206.0 29823.3 30270.2 30547.8 30641.8 1043.5 1046.3 1051.4 1059.3 1078.5 15139.2 15710.1 15799.4 16086.4 16206.2 467564.9 469762.0 471401.0 471843.0 648098.0 45807.5 53537.7 54858.5 55238.4 59020.4 1299.7 1301.6 1303.2 1315.4 1319.4 28878.3 30559.5 30568.2 31002.5 31297.0 46470.0 47000.8 47035.8 47101.0 47111.0 390411.0 392213.0 392926.0 393449.0 393743.0 37053.4 37139.0 37405.0 37450.8 38661.8 42589.1 43767.0 44428.6 44474.9 44602.8 37003.3 37446.3 38164.6 38741.0 39715.8 37066.8 37077.0 37268.4 37998.9 38991.8 37615.6 38519.0 38637.0 38770.0 38796.8 31433.5 33555.7 33857.3 34442.7 34487.5 25745.5 25915.6 25919.7 26167.6 26635.5 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#2] jquery.html Cycles:180 Average:27455.65 Median:393.01 stddev:71751.36 (18256.9%) stddev-sans-first:71923.81 05:11:37 INFO - PROCESS | 7380 | Values: 365.1 373.6 382.8 386.7 399.3 14158.9 18295.7 19584.0 19991.8 20077.5 16703.0 17671.4 18002.2 18101.3 18143.6 5491.7 5649.6 5695.3 5702.3 5704.0 4069.1 4360.1 4406.8 5550.3 5663.4 6333.5 6430.1 6443.5 6443.5 6447.7 6445.2 6448.2 6774.4 6970.9 7031.7 6601.7 6884.2 6896.4 6900.6 6910.6 23132.7 23416.0 23688.2 23792.3 24405.4 2230.6 2279.3 2292.2 2303.0 3003.9 14030.4 14775.4 15115.6 15359.4 15735.6 1935.3 1994.5 1996.9 2024.1 2088.0 63110.0 83935.6 85320.0 86388.6 88757.6 16492.8 16636.7 16861.4 17099.9 17164.5 29440.7 29451.4 29533.0 29630.1 29654.3 8662.3 8806.7 8859.1 9081.6 9164.3 7096.5 7122.3 7205.2 7344.9 7372.5 8317.4 8462.1 8477.1 8497.4 8681.8 3127.8 3246.9 3416.8 3472.5 3527.5 425.4 441.4 464.9 817.2 913.2 10675.0 11213.6 11332.3 11395.7 11685.9 434.9 441.8 448.4 452.4 467.8 6049.5 6337.3 9512.5 10457.0 10601.1 429395.0 432580.0 432857.5 432928.0 443164.0 86458.0 86846.6 87016.1 87265.0 87481.6 977.1 986.0 1026.9 1028.2 1031.4 15803.8 16452.8 16473.3 16726.3 16874.0 36398.5 37106.0 37601.2 39906.4 42637.6 51886.0 53178.7 53957.0 54539.0 54708.7 7605.6 7775.1 7922.2 8000.5 8037.6 10265.7 11530.3 12080.7 12255.4 12935.2 10515.5 10796.5 10942.7 11057.8 11073.9 10664.7 10677.3 10697.7 10797.2 11253.2 10645.3 10709.5 10851.6 10910.5 11238.3 7599.3 7628.7 7629.2 7850.3 8121.6 8297.1 10796.6 10877.9 11062.3 11145.7 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#3] mootools.html Cycles:180 Average:4950.05 Median:5003.20 stddev:2729.58 (54.6%) stddev-sans-first:2723.26 05:11:37 INFO - PROCESS | 7380 | Values: 1275.1 1344.0 1357.5 1439.8 1670.2 6562.8 7276.7 7400.4 7536.5 7716.0 7590.4 7660.7 7668.1 7669.4 7672.6 1825.4 2076.3 2115.2 2117.4 2118.4 1876.5 2078.5 2141.0 2141.3 2150.0 2062.6 2090.0 2096.9 2097.4 2101.7 2079.7 2099.5 2105.0 2105.2 2109.3 2101.1 2119.3 2122.4 2125.9 2126.1 7542.2 7577.2 7625.3 7629.7 7641.7 4640.3 4763.9 4765.4 4765.5 4765.7 2879.7 2953.1 3028.3 3121.5 3139.0 863.8 872.0 877.7 947.5 948.1 9938.0 9938.5 9946.8 9989.8 10021.9 3962.1 4211.3 4254.1 4257.4 4286.7 8412.2 8416.7 8472.4 8505.0 8509.4 4682.5 4700.7 4737.4 4815.3 4819.7 3765.9 4187.5 4400.8 4409.4 4411.1 3510.7 3517.2 3627.6 3636.1 3646.5 1165.1 1178.3 1182.2 1188.1 1189.9 779.7 780.4 872.3 918.9 932.8 4807.6 5088.8 5149.1 5335.1 5337.6 398.4 400.3 410.3 412.6 415.2 3439.1 3557.3 3569.1 3605.4 3648.7 8761.9 9202.4 9207.3 9207.6 9219.8 9154.5 9158.7 9162.3 9173.9 9175.2 6901.3 7012.4 7159.6 7243.5 7252.9 4841.4 4917.0 4929.7 4931.8 5074.6 8347.4 8413.2 8436.9 8488.5 8508.3 7974.9 8277.5 8284.0 8518.6 8525.7 6099.1 6270.2 6732.4 6822.9 6866.2 6927.2 7070.1 7124.7 7307.3 7315.9 6464.9 6596.2 6607.6 6638.9 6858.9 6550.1 6583.6 6619.2 6789.6 6829.6 5956.6 6024.4 6095.0 6096.4 6111.5 4232.8 4287.5 4289.9 4302.7 4405.9 4172.5 4307.8 4336.6 4345.5 4383.3 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#4] prototype.html Cycles:180 Average:4596.15 Median:5132.13 stddev:1285.63 (25.1%) stddev-sans-first:1249.23 05:11:37 INFO - PROCESS | 7380 | Values: 355.9 371.2 374.2 378.1 381.9 5082.7 5153.9 5173.5 5175.4 5182.6 5051.3 5134.7 5145.6 5188.8 5209.5 4043.5 4116.0 4136.8 4189.6 4192.3 4189.5 4193.5 4209.8 4221.5 4242.9 4196.4 4198.0 4205.6 4216.4 4218.3 4061.5 4193.2 4195.9 4213.4 4219.3 3765.6 3788.3 3788.3 3788.8 3792.5 5064.1 5086.6 5095.2 5103.4 5103.6 4627.7 4735.6 4772.4 4780.3 4786.3 5351.2 5400.0 5413.9 5434.0 5435.5 4087.5 4113.6 4146.3 4188.4 4200.4 5545.8 5689.5 5705.6 5713.2 5733.6 4255.4 4265.1 4276.3 4280.4 4290.0 4322.3 4333.2 4333.6 4336.4 4343.3 4494.3 4779.5 4783.7 4792.7 4828.5 5075.7 5468.4 5471.9 5489.1 5514.8 1453.3 1456.7 1457.4 1463.3 1465.9 1006.0 1059.3 1059.7 1062.3 1068.7 5085.5 5129.3 5129.6 5136.8 5148.7 5372.7 5389.7 5390.3 5412.9 5413.3 4937.9 5042.5 5085.8 5101.9 5128.0 2869.3 2870.8 2885.2 2887.8 2897.6 5561.9 5615.6 5618.5 5632.5 5639.5 5345.8 5409.2 5489.7 5490.9 5511.3 5590.3 5600.3 5620.6 5643.5 5673.4 5225.4 5348.8 5362.8 5427.4 5429.5 5220.7 5253.4 5275.0 5282.0 5305.4 5527.3 5531.6 5537.5 5549.4 5562.3 3697.6 3930.9 3969.0 3984.7 3995.7 5322.5 5487.4 5543.9 5558.3 5582.4 5332.8 5438.8 5472.1 5484.4 5494.6 5464.8 5479.4 5484.3 5485.3 5575.4 5278.4 5432.9 5448.9 5452.9 5470.6 5481.2 5481.5 5489.5 5500.4 5514.3 5231.2 5347.9 5355.2 5428.0 5475.0 05:11:37 INFO - PROCESS | 7380 | 05:11:37 INFO - PROCESS | 7380 | [#5] yui.html Cycles:180 Average:17353.66 Median:24230.50 stddev:22381.60 (92.4%) stddev-sans-first:22409.46 05:11:37 INFO - PROCESS | 7380 | Values: 702.5 736.2 741.2 772.3 805.9 15157.0 15242.7 15592.6 15686.9 16106.4 13329.4 13707.0 14599.0 14772.0 14786.2 773.3 792.3 793.1 793.2 793.2 659.8 683.6 766.5 790.9 798.0 824.3 829.1 830.3 831.2 838.2 826.7 828.3 828.7 828.7 829.2 513.0 524.5 589.6 599.6 608.8 14765.5 14797.2 14815.9 14818.3 14919.9 13551.1 13577.8 13654.0 13656.3 13667.7 12197.8 12252.3 12365.8 12381.2 12725.2 4262.2 4275.4 4278.9 4454.5 4481.6 74402.0 75274.2 76164.6 76931.6 78635.0 10880.5 10940.6 10956.9 11017.8 11540.5 19870.0 20130.9 20266.9 20473.4 20491.7 7822.1 7822.7 7915.5 7947.8 8193.8 4175.0 4181.6 4221.7 4306.9 4347.6 3071.5 3154.0 3165.2 3297.6 3359.7 575.2 576.8 577.4 588.3 588.6 545.6 615.2 659.5 683.6 699.7 8688.0 8825.6 8913.2 9077.3 9231.5 551.0 553.1 632.3 690.6 712.1 3995.0 4159.7 4262.7 4372.6 4405.7 76341.0 77859.0 77968.6 78700.2 79326.6 67526.6 69277.0 69543.3 69760.3 69811.7 60058.7 60264.7 60666.7 60870.7 61522.0 8061.3 8076.4 8341.0 8394.7 8462.4 43093.8 43423.1 43753.1 44055.3 45884.3 54801.5 59835.1 59981.7 60607.7 61575.0 11408.7 11840.3 11885.2 12261.3 12300.8 12477.8 12606.8 12678.2 12794.9 13135.9 13496.6 13740.6 13813.9 14050.6 14325.0 12943.6 13335.9 13651.5 13878.3 14624.8 12571.7 12807.4 12999.2 13287.5 13672.6 10705.3 10723.4 10836.2 11156.5 11441.3 10871.0 11162.9 11497.6 11565.8 11716.9 05:11:37 INFO - PROCESS | 7380 | -------- Summary: end -------- 05:11:37 INFO - PROCESS | 7380 | 05:11:38 INFO - TEST-INFO | 7380: exit 0 05:11:38 INFO - TEST-OK | dromaeo_css | took 1118095ms 05:11:38 INFO - TEST-START | kraken 05:11:38 INFO - operating with platform_type : linux_ 05:11:38 INFO - Initialising browser for kraken test... 05:11:38 INFO - TEST-INFO | started process 7691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7Bxof/profile http://localhost:39229/getInfo.html) 05:11:41 INFO - PROCESS | 7691 | __metrics Screen width/height:1600/1200 05:11:41 INFO - PROCESS | 7691 | colorDepth:24 05:11:41 INFO - PROCESS | 7691 | Browser inner width/height: 1024/697 05:11:41 INFO - PROCESS | 7691 | __metrics 05:11:42 INFO - PROCESS | 7691 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:42 INFO - PROCESS | 7691 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:43 INFO - PROCESS | 7691 | console.error: PushService: 05:11:43 INFO - PROCESS | 7691 | stateChangeProcessEnqueue: Error transitioning state 05:11:43 INFO - PROCESS | 7691 | UnknownError 05:11:43 INFO - TEST-INFO | 7691: exit 0 05:11:43 INFO - Browser initialized. 05:11:43 INFO - Running cycle 1/1 for kraken test... 05:11:43 INFO - TEST-INFO | started process 7779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7Bxof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:55 INFO - PROCESS | 7779 | RSS: Main: 172195840 05:11:55 INFO - PROCESS | 7779 | 05:11:58 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39229/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:59 INFO - PROCESS | 7779 | RSS: Main: 234516480 05:11:59 INFO - PROCESS | 7779 | 05:12:02 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39229/tests/kraken/driver.html?testName=audio-dft) 05:12:02 INFO - PROCESS | 7779 | RSS: Main: 216653824 05:12:02 INFO - PROCESS | 7779 | 05:12:05 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39229/tests/kraken/driver.html?testName=audio-fft) 05:12:06 INFO - PROCESS | 7779 | RSS: Main: 299024384 05:12:06 INFO - PROCESS | 7779 | 05:12:08 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39229/tests/kraken/driver.html?testName=audio-oscillator) 05:12:08 INFO - PROCESS | 7779 | RSS: Main: 210710528 05:12:08 INFO - PROCESS | 7779 | 05:12:11 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:11 INFO - PROCESS | 7779 | RSS: Main: 214089728 05:12:11 INFO - PROCESS | 7779 | 05:12:14 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39229/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:15 INFO - PROCESS | 7779 | RSS: Main: 252874752 05:12:15 INFO - PROCESS | 7779 | 05:12:18 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39229/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:19 INFO - PROCESS | 7779 | RSS: Main: 253325312 05:12:19 INFO - PROCESS | 7779 | 05:12:22 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39229/tests/kraken/driver.html?testName=json-parse-financial) 05:12:22 INFO - PROCESS | 7779 | RSS: Main: 251891712 05:12:22 INFO - PROCESS | 7779 | 05:12:24 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:24 INFO - PROCESS | 7779 | RSS: Main: 213155840 05:12:24 INFO - PROCESS | 7779 | 05:12:26 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:27 INFO - PROCESS | 7779 | RSS: Main: 221085696 05:12:27 INFO - PROCESS | 7779 | 05:12:29 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:29 INFO - PROCESS | 7779 | RSS: Main: 229605376 05:12:29 INFO - PROCESS | 7779 | 05:12:32 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:33 INFO - PROCESS | 7779 | RSS: Main: 238469120 05:12:33 INFO - PROCESS | 7779 | 05:12:36 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:36 INFO - PROCESS | 7779 | RSS: Main: 235159552 05:12:36 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | Cycle 1(1): loaded http://localhost:39229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39229/tests/kraken/driver.html?testName=ai-astar) 05:12:38 INFO - PROCESS | 7779 | RSS: Main: 287735808 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | __start_tp_report 05:12:38 INFO - PROCESS | 7779 | _x_x_mozilla_page_load 05:12:38 INFO - PROCESS | 7779 | _x_x_mozilla_page_load_details 05:12:38 INFO - PROCESS | 7779 | |i|pagename|runs| 05:12:38 INFO - PROCESS | 7779 | |0;ai-astar;106;113;116;114;114;114;114;114;113;115 05:12:38 INFO - PROCESS | 7779 | |1;audio-beat-detection;150;124;134;179;127;128;127;124;144;126 05:12:38 INFO - PROCESS | 7779 | |2;audio-dft;162;161;161;162;163;162;161;162;162;162 05:12:38 INFO - PROCESS | 7779 | |3;audio-fft;75;76;76;121;77;77;76;78;91;75 05:12:38 INFO - PROCESS | 7779 | |4;audio-oscillator;85;84;106;83;85;85;94;84;86;106 05:12:38 INFO - PROCESS | 7779 | |5;imaging-gaussian-blur;127;127;127;128;127;127;127;128;128;127 05:12:38 INFO - PROCESS | 7779 | |6;imaging-darkroom;146;146;147;145;147;145;146;146;146;145 05:12:38 INFO - PROCESS | 7779 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:12:38 INFO - PROCESS | 7779 | |8;json-parse-financial;53;51;51;51;53;56;64;52;53;53 05:12:38 INFO - PROCESS | 7779 | |9;json-stringify-tinderbox;64;64;64;64;64;63;63;64;64;64 05:12:38 INFO - PROCESS | 7779 | |10;stanford-crypto-aes;85;80;80;82;81;80;81;81;82;80 05:12:38 INFO - PROCESS | 7779 | |11;stanford-crypto-ccm;134;135;141;143;141;138;137;137;183;141 05:12:38 INFO - PROCESS | 7779 | |12;stanford-crypto-pbkdf2;173;176;179;170;168;171;172;174;172;171 05:12:38 INFO - PROCESS | 7779 | |13;stanford-crypto-sha256-iterative;67;66;67;64;67;65;65;69;66;63 05:12:38 INFO - PROCESS | 7779 | __end_tp_report 05:12:38 INFO - PROCESS | 7779 | __start_cc_report 05:12:38 INFO - PROCESS | 7779 | _x_x_mozilla_cycle_collect,1684 05:12:38 INFO - PROCESS | 7779 | __end_cc_report 05:12:38 INFO - PROCESS | 7779 | __startTimestamp1481548358779__endTimestamp 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | ------- Summary: start ------- 05:12:38 INFO - PROCESS | 7779 | Number of tests: 14 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 05:12:38 INFO - PROCESS | 7779 | Values: 106.0 113.0 116.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:131.00 stddev:17.40 (13.3%) stddev-sans-first:17.74 05:12:38 INFO - PROCESS | 7779 | Values: 150.0 124.0 134.0 179.0 127.0 128.0 127.0 124.0 144.0 126.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:12:38 INFO - PROCESS | 7779 | Values: 162.0 161.0 161.0 162.0 163.0 162.0 161.0 162.0 162.0 162.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:14.43 (18.9%) stddev-sans-first:15.07 05:12:38 INFO - PROCESS | 7779 | Values: 75.0 76.0 76.0 121.0 77.0 77.0 76.0 78.0 91.0 75.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:85.00 stddev:9.07 (10.7%) stddev-sans-first:9.45 05:12:38 INFO - PROCESS | 7779 | Values: 85.0 84.0 106.0 83.0 85.0 85.0 94.0 84.0 86.0 106.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#5] imaging-gaussian-blur Cycles:10 Average:127.30 Median:127.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:12:38 INFO - PROCESS | 7779 | Values: 127.0 127.0 127.0 128.0 127.0 127.0 127.0 128.0 128.0 127.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:12:38 INFO - PROCESS | 7779 | Values: 146.0 146.0 147.0 145.0 147.0 145.0 146.0 146.0 146.0 145.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:12:38 INFO - PROCESS | 7779 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.92 (7.4%) stddev-sans-first:4.15 05:12:38 INFO - PROCESS | 7779 | Values: 53.0 51.0 51.0 51.0 53.0 56.0 64.0 52.0 53.0 53.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 05:12:38 INFO - PROCESS | 7779 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 64.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.55 (1.9%) stddev-sans-first:0.83 05:12:38 INFO - PROCESS | 7779 | Values: 85.0 80.0 80.0 82.0 81.0 80.0 81.0 81.0 82.0 80.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:141.00 stddev:14.35 (10.2%) stddev-sans-first:14.85 05:12:38 INFO - PROCESS | 7779 | Values: 134.0 135.0 141.0 143.0 141.0 138.0 137.0 137.0 183.0 141.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:3.13 (1.8%) stddev-sans-first:3.32 05:12:38 INFO - PROCESS | 7779 | Values: 173.0 176.0 179.0 170.0 168.0 171.0 172.0 174.0 172.0 171.0 05:12:38 INFO - PROCESS | 7779 | 05:12:38 INFO - PROCESS | 7779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.73 (2.6%) stddev-sans-first:1.79 05:12:38 INFO - PROCESS | 7779 | Values: 67.0 66.0 67.0 64.0 67.0 65.0 65.0 69.0 66.0 63.0 05:12:38 INFO - PROCESS | 7779 | -------- Summary: end -------- 05:12:38 INFO - PROCESS | 7779 | 05:12:39 INFO - TEST-INFO | 7779: exit 0 05:12:40 INFO - TEST-OK | kraken | took 61956ms 05:12:40 INFO - SUITE-END | took 1180s 05:12:40 INFO - Completed test suite (00:19:40) 05:12:40 INFO - javascript benchmark 05:12:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.7159855613, 3177.7457803375733, 3195.089399521137, 3209.0, 3227.548143259944, 5043.5965122790185, 5083.5424811767025, 5106.77019534121, 5206.713630750312, 5210.270562121302, 5152.871178220546, 5170.069387510247, 5222.321098257221, 5274.894502109955, 5367.436419175979, 4707.152712511746, 4762.0475904819, 4792.90414191716, 4838.129136755382, 4845.709257444547, 4727.243641017438, 4831.879203019935, 4842.346283251769, 4850.684705494149, 4880.755962201875, 4854.466008739036, 4878.146324393235, 4882.511748825124, 4912.975435122819, 4918.852434426973, 4639.559241872017, 4673.742944138071, 4679.60223381013, 4817.349657796188, 4868.683535570177, 4646.117237724855, 4675.88310292242, 4693.413323334583, 4713.670043096985, 4763.214069678499, 5082.898342033139, 5122.436531981479, 5142.588592912558, 5147.047796157723, 5198.6880787152895, 5363.597730170253, 5479.698616576086, 5482.533984611313, 5482.753276102585, 5484.369297530795, 5395.271638328853, 5430.511253987121, 5469.0, 5474.562035037187, 5586.720663966786, 5212.270282160501, 5214.0875346814155, 5215.400228973716, 5219.686818790847, 5219.791208351661, 5660.85847853807, 5663.235463212496, 5663.292088488939, 5666.824632728922, 5724.742386592613, 5314.468553144655, 5343.465653434625, 5365.141577347606, 5383.892322153535, 5400.189971504227, 5457.045017121988, 5484.177373393943, 5491.36849262332, 5504.889902201933, 5548.639338442988, 5436.891262174734, 5484.067708489566, 5486.31421072366, 5492.80775172867, 5533.0, 5376.220448035091, 5425.077736784756, 5429.484199001088, 5505.724713764296, 5512.062949298629, 4280.91438171241, 4310.396544483775, 4319.049809042006, 4332.783360831946, 4364.9960509083085, 3917.216556688674, 3921.0197450637343, 3926.391409331558, 3950.664193543581, 3972.0, 5226.529612334832, 5231.058409486329, 5233.215017747369, 5234.7644356004075, 5234.816781412632, 5354.277172581652, 5398.055340315429, 5525.944740552623, 5529.060059789846, 5532.861678458071, 5208.739563021833, 5250.606204534599, 5254.65844720092, 5260.13207820713, 5299.12564426873, 4797.160496913096, 4806.44725856524, 4807.591354734886, 4811.27830825372, 4842.975785121052, 5522.22688823565, 5578.44215578447, 5601.075822489406, 5723.7996670116345, 5733.168690539848, 5547.362053363915, 5569.610127291051, 5590.385057643574, 5599.972000139973, 5621.971890140523, 5783.855403614775, 5784.768609255751, 5786.392428794916, 5786.623869448473, 5791.160281759206, 5472.589555783412, 5479.2602998594675, 5480.808171713971, 5487.75305111263, 5488.121900495901, 5377.247185394126, 5384.030874442638, 5494.835154945358, 5495.368032676293, 5530.391656917655, 5451.781928722807, 5455.536279416294, 5455.672659640434, 5459.39946605881, 5494.36814766307, 5362.65142765719, 5393.7033463159905, 5404.216388623706, 5432.320959880015, 5451.781928722807, 5170.819021334235, 5281.0, 5316.6544174628525, 5380.542653874308, 5401.621886468067, 5485.61600687964, 5487.972560137174, 5490.835274941758, 5492.231087647812, 5545.3622833374675, 5169.612279079009, 5197.506236907488, 5199.66202196856, 5267.57859371257, 5360.142377219782], "value": 5124.361705982283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.0882662713328, 555.3973938276969, 570.0707846210676, 571.6598623818829, 578.884223155369, 30733.69266307336, 31319.0, 38203.617963820354, 40493.79753101238, 40636.79681601588, 42095.78952105243, 42376.0, 42417.57582424175, 42488.57511424885, 42588.574114258925, 8442.451240669352, 8635.0, 8639.784005399884, 8640.481571105754, 8643.394962352639, 7746.883796743054, 7998.680052797881, 9918.950405247964, 10219.335743176707, 10227.590896364136, 10156.695299141038, 10216.948915255412, 10223.28437009406, 10227.846582301234, 10228.284020118595, 10137.645182418617, 10199.694009179737, 10213.18294536439, 10214.948925255401, 10251.231157663206, 9997.0, 10071.34536255141, 10083.697489075339, 10090.19278457729, 10091.848622270672, 39157.608423915684, 39395.0, 39457.60542394597, 39489.40765888514, 39536.802315988236, 3266.216108134031, 3362.09223509651, 3392.6098498672477, 3425.047722798006, 3854.8650797221962, 29540.0, 29586.082783443184, 29803.0, 30642.38715225705, 30703.539446908315, 4054.9391759123637, 4129.587041295877, 4134.536832247403, 4303.784810759481, 4320.740755554677, 308544.4572777144, 308683.0, 309252.0, 309542.0, 310518.0, 51391.48608513942, 51602.22596661053, 51784.74107629438, 51823.22265166025, 51840.22239666408, 54037.459625403244, 54144.0, 54300.72849635727, 54471.0, 54570.0, 13328.200307981358, 13545.187288762705, 13550.390232439564, 13559.796603050961, 13627.454901804014, 10162.695119146438, 10403.427811470441, 11215.94392028051, 11320.433978301053, 11337.603183888525, 14020.71958560823, 14055.0, 14123.364448599632, 14741.705165896621, 14998.925005374904, 6069.696515174223, 6361.713722882481, 6400.487960963112, 6410.839729006719, 6458.160439142881, 924.6440120553635, 954.5704433005176, 999.8200323941614, 1097.5993762276712, 1132.6262333429947, 28206.0, 29823.254418639706, 30270.243243919078, 30547.847260763552, 30641.84679076635, 1043.5408420295046, 1046.3460337289193, 1051.358671210561, 1059.3220338983058, 1078.4553800330782, 15139.167345796088, 15710.135942523042, 15799.447019354267, 16086.43697470583, 16206.189690515426, 467564.86527020537, 469762.0, 471401.0, 471843.0, 648098.0, 45807.541924581, 53537.73231133819, 54858.45141548533, 55238.447615524135, 59020.40979590235, 1299.707565797688, 1301.557470460048, 1303.1985329022773, 1315.3949183375755, 1319.399673148715, 28878.278043048253, 30559.54160687636, 30568.235794104436, 31002.534961975136, 31297.0, 46470.0, 47000.7649961748, 47035.764821175675, 47101.0, 47111.0, 390411.0, 392213.0, 392926.0, 393449.0, 393743.0, 37053.44419833759, 37139.0, 37405.0, 37450.8127459361, 38661.80669096637, 42589.148217036105, 43767.0, 44428.55571444244, 44474.888127797065, 44602.77698611486, 37003.25993480169, 37446.2510749778, 38164.61835381722, 38741.0, 39715.80142099386, 37066.8146659265, 37077.0, 37268.44097338488, 37998.86003419902, 38991.805040974614, 37615.62384376121, 38519.0, 38637.0, 38770.0, 38796.80601596974, 31433.52849707302, 33555.66444335526, 33857.322853543286, 34442.655573443946, 34487.4826877602, 25745.485090297716, 25915.594348961098, 25919.740802591732, 26167.607485888107, 26635.467290654466], "value": 19043.479638801626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.09274452984346, 373.60024773492364, 382.8353807862618, 386.69064748201436, 399.3271337795814, 14158.929205353972, 18295.725564116532, 19583.99999999998, 19991.800081999176, 20077.498062548442, 16703.0, 17671.381501647444, 18002.189901454432, 18101.28480727888, 18143.637127257447, 5491.725413729318, 5649.576281778863, 5695.259616249882, 5702.344230413514, 5703.9714801425935, 4069.104796944682, 4360.084382279725, 4406.845760398387, 5550.2507161533285, 5663.4336566343245, 6333.524985626096, 6430.067640192169, 6443.48452123829, 6443.516736244777, 6447.742090316405, 6445.1943507061615, 6448.226212854464, 6774.356436138559, 6970.93029069713, 7031.683574239171, 6601.6699165041555, 6884.242733299333, 6896.413804826596, 6900.585964842076, 6910.550814197061, 23132.65301020486, 23416.0, 23688.170914017926, 23792.286231413087, 24405.38986525333, 2230.5761905237955, 2279.338991692407, 2292.2435596253194, 2303.0212159832004, 3003.9249018774485, 14030.43878244869, 14775.408983640642, 15115.622109447242, 15359.385624575003, 15735.606609834731, 1935.3226370770258, 1994.4814348269554, 1996.9201231950703, 2024.119508014004, 2087.9791202087936, 63110.0, 83935.580322098, 85319.99999999937, 86388.56805715994, 88757.55621221918, 16492.752608710878, 16636.6672666546, 16861.409850655167, 17099.914500427418, 17164.485065447807, 29440.700673878906, 29451.410971780446, 29533.0, 29630.111096667133, 29654.258643534085, 8662.263707584925, 8806.691765788166, 8859.11408859109, 9081.591328390106, 9164.312676549285, 7096.53872498286, 7122.2521635228595, 7205.171405288354, 7344.926550734531, 7372.48392612512, 8317.41778075529, 8462.069172391031, 8477.067522572512, 8497.36269779769, 8681.826363472695, 3127.827969461656, 3246.9086557638516, 3416.7949923004203, 3472.5138480612736, 3527.5414196154848, 425.402309754795, 441.4085125931268, 464.92561190209403, 817.1950628630794, 913.1690161952591, 10675.032972303303, 11213.607523736793, 11332.320060796214, 11395.658130256106, 11685.941570292263, 434.8586709319421, 441.77690266415254, 448.4260147011765, 452.4231604704029, 467.7754677754697, 6049.485793707584, 6337.33457986914, 9512.47681377517, 10457.0, 10601.098906592872, 429395.0, 432580.0, 432857.52141153725, 432928.0, 443164.0, 86458.0, 86846.56576717076, 87016.07742761254, 87265.0, 87481.56259218663, 977.0571398600526, 985.9950700246453, 1026.9075783179549, 1028.218553899042, 1031.417249254169, 15803.762943555626, 16452.75320870164, 16473.258703358617, 16726.330946761995, 16874.0, 36398.454023189144, 37106.0, 37601.2479750398, 39906.40140397838, 42637.5736242646, 51886.0, 53178.73410632922, 53957.0, 54539.0, 54708.72645636746, 7605.581693006938, 7775.14473407936, 7922.168172341821, 8000.51996880189, 8037.557934313435, 10265.74335641615, 11530.250533715282, 12080.697982550155, 12255.448504817126, 12935.223886566837, 10515.474226288808, 10796.460176991277, 10942.671719848417, 11057.834132487858, 11073.889261107286, 10664.733381665521, 10677.305975111592, 10697.732556686145, 10797.24419290642, 11253.21227514099, 10645.308054976402, 10709.464526773785, 10851.565937362417, 10910.509027093642, 11238.325700458, 7599.316061554487, 7628.656710447932, 7629.2370762923265, 7850.293473587404, 8121.634526446206, 8297.103607090929, 10796.622118225825, 10877.945610271898, 11062.280951738112, 11145.72135696614], "value": 9165.663549418354, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.1265383212506, 1344.0457275334513, 1357.5045108535385, 1439.8344190418104, 1670.2066518403751, 6562.835929101769, 7276.708931642735, 7400.407967362611, 7536.547807131576, 7715.961420192905, 7590.354819840307, 7660.655270512826, 7668.118166410864, 7669.4247931405225, 7672.578008209546, 1825.3702472646914, 2076.3148161106797, 2115.164510018542, 2117.3965419855344, 2118.353902059871, 1876.5308672831793, 2078.5450184870574, 2141.047233980871, 2141.2612648636273, 2149.978500215001, 2062.608104460155, 2090.0385822521657, 2096.937091887246, 2097.381272524601, 2101.663733802592, 2079.740032495938, 2099.496120930981, 2105.0316854247067, 2105.157936825267, 2109.3144727963395, 2101.0965284927474, 2119.268852245988, 2122.416335507732, 2125.90433430496, 2126.1282874021576, 7542.20806815282, 7577.204393538709, 7625.275598818103, 7629.6948122075055, 7641.656125474367, 4640.280756482717, 4763.857084287477, 4765.404324459442, 4765.523447655241, 4765.714057156547, 2879.6544414670375, 2953.1288269960414, 3028.333766571373, 3121.5317702344605, 3138.984305078483, 863.818598094401, 871.9651213951435, 877.7147427086222, 947.5404428852002, 948.0945696859483, 9938.0, 9938.503074846229, 9946.751331216778, 9989.75025624358, 10021.949890250575, 3962.1481381503113, 4211.347241177622, 4254.149170165979, 4257.425247591597, 4286.678499112579, 8412.242898139197, 8416.663333466715, 8472.364572657076, 8504.957475212585, 8509.446885952517, 4682.508336624674, 4700.6944548604915, 4737.431508219036, 4815.3499277597075, 4819.7108173509705, 3765.86819461323, 4187.5184353799095, 4400.823967041347, 4409.382686423904, 4411.051623900877, 3510.7015903647966, 3517.243792584555, 3627.5828279748166, 3636.1455058061333, 3646.4894914711963, 1165.091228841505, 1178.3460179600404, 1182.1901997131993, 1188.085174415695, 1189.9464524096436, 779.6576630058398, 780.42248735935, 872.284726524244, 918.8713580098791, 932.8367535681228, 4807.6394270429855, 5088.847334579968, 5149.124648809711, 5335.093034184198, 5337.599680024014, 398.44218094667696, 400.2675104558651, 410.3106780608606, 412.5523806669737, 415.2484003952795, 3439.105832483522, 3557.324108419392, 3569.1255642367787, 3605.4231322988194, 3648.689861361761, 8761.868571971425, 9202.355835091614, 9207.309451791143, 9207.63169473227, 9219.815603687888, 9154.450732956044, 9158.679446219483, 9162.267018638493, 9173.862392063991, 9175.22010629104, 6901.309869013058, 7012.439004879496, 7159.642017899084, 7243.4929554931705, 7252.927470725225, 4841.443234028132, 4917.041176970456, 4929.728864912321, 4931.753412329297, 5074.644774865724, 8347.373946953881, 8413.200745929127, 8436.873446898178, 8488.533130677872, 8508.319334453105, 7974.920250797418, 8277.54473503939, 8284.0, 8518.61666225009, 8525.658973640984, 6099.11562823397, 6270.184875966095, 6732.360425759545, 6822.863542729018, 6866.176058872968, 6927.203371612329, 7070.080889484334, 7124.715011399486, 7307.26927307265, 7315.890261645973, 6464.8707025858275, 6596.175478065242, 6607.57050791697, 6638.933610663831, 6858.897116543156, 6550.115734375799, 6583.63789991555, 6619.172603424572, 6789.62657053847, 6829.590224586541, 5956.612820166675, 6024.427679370453, 6095.0, 6096.390360964046, 6111.511079113571, 4232.830686772618, 4287.506936702319, 4289.892752681208, 4302.677299202635, 4405.911881762411, 4172.4784401949755, 4307.8276868924895, 4336.609705126553, 4345.456817897762, 4383.342498625232], "value": 3945.0214694347305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.87544359474185, 371.1519178676724, 374.16747736286766, 378.0869200879874, 381.85298660015894, 5082.745862706859, 5153.896922061556, 5173.5343819056325, 5175.378954525458, 5182.611304152189, 5051.282563928264, 5134.691918484894, 5145.639805213627, 5188.792448302072, 5209.531142197211, 4043.4743483347124, 4116.0, 4136.834526618946, 4189.6229339359525, 4192.287311157095, 4189.497260328765, 4193.51774545928, 4209.810558524859, 4221.514525829522, 4242.9151416971645, 4196.433481479991, 4197.979010104945, 4205.621494065534, 4216.409702641633, 4218.3250679891225, 4061.532923713781, 4193.161367726451, 4195.937060944088, 4213.367994800774, 4219.346001369778, 3765.604611515806, 3788.29916465452, 3788.3370410178386, 3788.8484460621544, 3792.4500947362753, 5064.11378008847, 5086.643934924557, 5095.184770436712, 5103.413107492649, 5103.617228707824, 4627.652926030528, 4735.644826638016, 4772.379590653193, 4780.306855505967, 4786.305985632064, 5351.17056856184, 5399.9730001350135, 5413.945860541423, 5434.049041417736, 5435.483629055233, 4087.509498860156, 4113.568075352105, 4146.295129827907, 4188.350805625133, 4200.411942328076, 5545.805896793593, 5689.459501347365, 5705.6006079574445, 5713.171785028792, 5733.627314224604, 4255.404243405926, 4265.0830071534765, 4276.2516559601945, 4280.400743895857, 4289.9571004289555, 4322.286822674287, 4333.158407676788, 4333.5883091106925, 4336.4145840311785, 4343.3484977253665, 4494.303382975644, 4779.498152693986, 4783.6651434399255, 4792.664513484023, 4828.493008234155, 5075.746212689351, 5468.398476167618, 5471.917921231185, 5489.066858634042, 5514.80698175562, 1453.2951518513512, 1456.6940942402002, 1457.358762144653, 1463.2537405923056, 1465.8566318271764, 1006.0, 1059.3008614314515, 1059.6979860739807, 1062.2882668612049, 1068.6740544134113, 5085.542301192911, 5129.281900533928, 5129.563987061067, 5136.845894623092, 5148.742562871841, 5372.70450125239, 5389.652586853286, 5390.326209223847, 5412.91880621791, 5413.323334583177, 4937.87655308613, 5042.546170844642, 5085.847424577269, 5101.897962040738, 5128.0, 2869.297022229567, 2870.8277503349864, 2885.192146199068, 2887.768978481716, 2897.608822808936, 5561.916571251434, 5615.606907516516, 5618.4662457066515, 5632.549840819257, 5639.464250896158, 5345.81289654868, 5409.24270602116, 5489.725513724377, 5490.917636235459, 5511.283533140666, 5590.301212348457, 5600.263918185376, 5620.550355971431, 5643.548516118701, 5673.404292549388, 5225.425203227566, 5348.7593058311695, 5362.758675859518, 5427.430119837518, 5429.484199001246, 5220.686758794484, 5253.395859476209, 5274.97362513185, 5282.0, 5305.389880163831, 5527.281453411031, 5531.557475402039, 5537.473939975695, 5549.445055494418, 5562.332520097614, 3697.59326474093, 3930.8820735377985, 3968.960310396859, 3984.7210695251056, 3995.7402768819934, 5322.520973112283, 5487.4483365235355, 5543.861403464945, 5558.276444542226, 5582.441755824548, 5332.840014799563, 5438.782448702166, 5472.127133254914, 5484.369297530835, 5494.615376923737, 5464.781408743605, 5479.424660410599, 5484.2596249505805, 5485.286912701324, 5575.386707462095, 5278.392984806796, 5432.918506222489, 5448.891022179455, 5452.909418116314, 5470.617056805985, 5481.177823326533, 5481.5340696041285, 5489.505944465017, 5500.394956554695, 5514.270436134139, 5231.241469986907, 5347.946520534901, 5355.169948657965, 5428.0, 5474.972625136849], "value": 4205.277229798118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.483674499243, 736.2306389822635, 741.232824027132, 772.2972095393193, 805.8670319397299, 15157.0, 15242.695146097085, 15592.610184745387, 15686.921565392156, 16106.436274730388, 13329.400176992034, 13707.040507164502, 14599.0, 14772.0, 14786.18675972821, 773.2885745114494, 792.2988155482411, 793.1235984237421, 793.1711361627114, 793.175097898188, 659.7624855052177, 683.6240067962625, 766.4634755671025, 790.9169537198597, 797.9640916158758, 824.3281725393784, 829.1252728371566, 830.3440282177073, 831.1771346367113, 838.1534650003509, 826.6569373709904, 828.3373301358889, 828.6809578312333, 828.7016673997356, 829.1625458287174, 513.0431744795928, 524.5410266017235, 589.6403194051625, 599.6342231238941, 608.8325710429667, 14765.483208087773, 14797.186154761484, 14815.851841481663, 14818.33317500715, 14919.925400373037, 13551.119177253448, 13577.796333055012, 13654.0, 13656.317184140753, 13667.726645467035, 12197.78412404125, 12252.264864108181, 12365.814512782315, 12381.195222310522, 12725.236485810789, 4262.232798096342, 4275.4228179195725, 4278.914421711548, 4454.510003899569, 4481.596656300949, 74402.0, 75274.24725752727, 76164.61917690432, 76931.61534192349, 78635.0, 10880.455977201109, 10940.617078402218, 10956.890431095588, 11017.779644407066, 11540.480678369493, 19870.0, 20130.899345503178, 20266.898665506873, 20473.385798426072, 20491.69262461064, 7822.139564647884, 7822.687092516236, 7915.525068495908, 7947.761567152879, 8193.8361232775, 4174.979125104355, 4181.581841815855, 4221.662267018631, 4306.89232769177, 4347.5652434756275, 3071.5392691096513, 3153.9684603153673, 3165.2245199925705, 3297.604287485517, 3359.664033596621, 575.2291928815407, 576.766409604111, 577.3793172339751, 588.2529187931389, 588.6409290332894, 545.6207935484879, 615.1633778061832, 659.535027805396, 683.5898460923406, 699.7375984005997, 8687.956560217284, 8825.558722063999, 8913.242374398249, 9077.273818094536, 9231.538423078819, 550.9531689806331, 553.0736017171222, 632.3265722006049, 690.5580428525748, 712.149690294225, 3994.980025099856, 4159.729617574848, 4262.65898728101, 4372.628326592212, 4405.66957478184, 76341.0, 77859.0, 77968.61015694885, 78700.21299787043, 79326.60336698279, 67526.64946701136, 69277.0, 69543.3045669547, 69760.30239697538, 69811.65094174497, 60058.69970650206, 60264.698676506334, 60666.696666516385, 60870.69564652148, 61522.0, 8061.2744852963515, 8076.394270429859, 8341.0, 8394.664213431639, 8462.365322600952, 43093.784531077144, 43423.13153736971, 43753.12493750043, 44055.33916991184, 45884.31173532333, 54801.45198547964, 59835.102473463805, 59981.70009149926, 60607.696961514914, 61575.0, 11408.714782130513, 11840.348780817138, 11885.16803823724, 12261.325627090595, 12300.753984920073, 12477.812832807334, 12606.810897836724, 12678.239305641691, 12794.936025319814, 13135.934320328719, 13496.595102146952, 13740.587782366545, 13813.930930345285, 14050.578482645536, 14325.0, 12943.611691649265, 13335.933320333335, 13651.522196723066, 13878.306084695927, 14624.780628290371, 12571.68570785701, 12807.359632018548, 12999.1550549214, 13287.468501260228, 13672.589822305346, 10705.250632455653, 10723.410212438392, 10836.241463097507, 11156.49795759209, 11441.313521188755, 10871.0, 11162.944185279022, 11497.597584084517, 11565.768684626428, 11716.94141529287], "value": 6970.683755644193, "unit": "score"}], "name": "dromaeo_css", "value": 6851.514916520871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 134.0, 179.0, 127.0, 128.0, 127.0, 124.0, 144.0, 126.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 121.0, 77.0, 77.0, 76.0, 78.0, 91.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 83.0, 85.0, 85.0, 94.0, 84.0, 86.0, 106.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 128.0, 127.0, 127.0, 127.0, 128.0, 128.0, 127.0], "value": 127.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 53.0, 56.0, 64.0, 52.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 82.0, 81.0, 80.0, 81.0, 81.0, 82.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 141.0, 143.0, 141.0, 138.0, 137.0, 137.0, 183.0, 141.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 179.0, 170.0, 168.0, 171.0, 172.0, 174.0, 172.0, 171.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 64.0, 67.0, 65.0, 65.0, 69.0, 66.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1531.8, "alertThreshold": 2.0}]} 05:12:40 INFO - Return code: 0 05:12:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:12:40 INFO - # TBPL SUCCESS # 05:12:40 INFO - Running post-action listener: _resource_record_post_action 05:12:40 INFO - [mozharness: 2016-12-12 13:12:40.599144Z] Finished run-tests step (success) 05:12:40 INFO - Running post-run listener: _resource_record_post_run 05:12:40 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393420800; Read time: 380; Write time: 278064 05:12:40 INFO - TinderboxPrint: CPU usage
13.2% 05:12:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 380 05:12:40 INFO - TinderboxPrint: I/O write bytes / time
393,420,800 / 278,064 05:12:40 INFO - TinderboxPrint: CPU idle
8,296.7 (86.8%) 05:12:40 INFO - TinderboxPrint: CPU user
1,210.9 (12.7%) 05:12:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:12:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103854080; Read time: 180; Write time: 82432 05:12:40 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289566720; Read time: 200; Write time: 195632 05:12:41 INFO - Running post-run listener: _upload_blobber_files 05:12:41 INFO - Blob upload gear active. 05:12:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:12:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:12:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:12:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:42 INFO - (blobuploader) - INFO - Done attempting. 05:12:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:12:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:12:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:43 INFO - (blobuploader) - INFO - Done attempting. 05:12:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:12:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:12:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:49 INFO - (blobuploader) - INFO - Done attempting. 05:12:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:49 INFO - Return code: 0 05:12:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6077ad99120f479beb41218f5ebd60c8b7bf8df2edefcdf7e2b9994e74efb2f487a495f57ac27b9a9ffbff350245ed80a7fc4cb6056474d6e70fdc28345f22e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae9ef0fd1be74789552d37668abf18d47abd60e9676ffc11e4083c9ae333e81ee0a30a4d3eb7a04491600e49ad24afbe025501bbf368f8fd3403e2ed32b857a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eeff6e2e92ee4ea727a625431e4da9e17e120b48370a6338984a4f46203421ff29ab8992b05e28ad874c2c23729e5d257d37e75b4eba9077740a65b6de7b528"} 05:12:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:49 INFO - Contents: 05:12:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6077ad99120f479beb41218f5ebd60c8b7bf8df2edefcdf7e2b9994e74efb2f487a495f57ac27b9a9ffbff350245ed80a7fc4cb6056474d6e70fdc28345f22e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae9ef0fd1be74789552d37668abf18d47abd60e9676ffc11e4083c9ae333e81ee0a30a4d3eb7a04491600e49ad24afbe025501bbf368f8fd3403e2ed32b857a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eeff6e2e92ee4ea727a625431e4da9e17e120b48370a6338984a4f46203421ff29ab8992b05e28ad874c2c23729e5d257d37e75b4eba9077740a65b6de7b528"} 05:12:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:49 INFO - Copying logs to upload dir... 05:12:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.354921 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-12 05:12:48.978594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 05:12:48.982316) ========= 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=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6077ad99120f479beb41218f5ebd60c8b7bf8df2edefcdf7e2b9994e74efb2f487a495f57ac27b9a9ffbff350245ed80a7fc4cb6056474d6e70fdc28345f22e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae9ef0fd1be74789552d37668abf18d47abd60e9676ffc11e4083c9ae333e81ee0a30a4d3eb7a04491600e49ad24afbe025501bbf368f8fd3403e2ed32b857a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eeff6e2e92ee4ea727a625431e4da9e17e120b48370a6338984a4f46203421ff29ab8992b05e28ad874c2c23729e5d257d37e75b4eba9077740a65b6de7b528"} build_url:https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/Z6Eigur-SL2rPW2lZKNWJw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6077ad99120f479beb41218f5ebd60c8b7bf8df2edefcdf7e2b9994e74efb2f487a495f57ac27b9a9ffbff350245ed80a7fc4cb6056474d6e70fdc28345f22e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae9ef0fd1be74789552d37668abf18d47abd60e9676ffc11e4083c9ae333e81ee0a30a4d3eb7a04491600e49ad24afbe025501bbf368f8fd3403e2ed32b857a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eeff6e2e92ee4ea727a625431e4da9e17e120b48370a6338984a4f46203421ff29ab8992b05e28ad874c2c23729e5d257d37e75b4eba9077740a65b6de7b528"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 05:12:49.008471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 05:12:49.008875) ========= 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=0333a256a5e4f052382dd180000001b1-1481540348.305288-821378265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 05:12:49.091508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 05:12:49.091896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 05:12:49.092256) ========= ========= Total master_lag: 0.17 =========