builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1481213132.88 results: success (0) buildid: 20161208071558 builduid: d28ea995524547d7b09f62354ba63f7c revision: 64e024fe44719575aa56c432e059ca065071ac95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:32.876349) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:32.876919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:32.877243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:32.893178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:32.893771) ========= 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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 08:05:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.02M=0.01s 2016-12-08 08:05:33 (1.02 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:33.046994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:33.047362) ========= 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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:33.097379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 08:05:33.097787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64e024fe44719575aa56c432e059ca065071ac95 --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 64e024fe44719575aa56c432e059ca065071ac95 --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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 08:05:34,102 truncating revision to first 12 chars 2016-12-08 08:05:34,102 Setting DEBUG logging. 2016-12-08 08:05:34,102 attempt 1/10 2016-12-08 08:05:34,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64e024fe4471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 08:05:35,127 unpacking tar archive at: mozilla-central-64e024fe4471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 08:05:34.484579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:34.485557) ========= script_repo_revision: 64e024fe44719575aa56c432e059ca065071ac95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:34.486617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:34.487372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 08:05:34.499272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-08 08:05:34.499621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:35 INFO - MultiFileLogger online at 20161208 08:05:35 in /builds/slave/test 08:05:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:05:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:35 INFO - {'append_to_log': False, 08:05:35 INFO - 'base_work_dir': '/builds/slave/test', 08:05:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:05:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:35 INFO - 'branch': 'Firefox-Non-PGO', 08:05:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:35 INFO - 'config_files': ('talos/linux_config.py',), 08:05:35 INFO - 'default_actions': ('clobber', 08:05:35 INFO - 'read-buildbot-config', 08:05:35 INFO - 'download-and-extract', 08:05:35 INFO - 'populate-webroot', 08:05:35 INFO - 'create-virtualenv', 08:05:35 INFO - 'install', 08:05:35 INFO - 'run-tests'), 08:05:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:35 INFO - 'download_minidump_stackwalk': True, 08:05:35 INFO - 'download_symbols': 'ondemand', 08:05:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:35 INFO - 'installer_path': 'installer.exe', 08:05:35 INFO - 'log_level': 'info', 08:05:35 INFO - 'log_name': 'talos', 08:05:35 INFO - 'log_to_console': True, 08:05:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:35 INFO - 'opt_config_files': (), 08:05:35 INFO - 'pip_index': False, 08:05:35 INFO - 'sps_profile': False, 08:05:35 INFO - 'sps_profile_interval': 0, 08:05:35 INFO - 'suite': 'dromaeojs', 08:05:35 INFO - 'system_bits': '32', 08:05:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:35 INFO - 'title': 'talos-linux64-ix-049', 08:05:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:35 INFO - 'use_talos_json': True, 08:05:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:35 INFO - 'work_dir': 'build'} 08:05:35 INFO - [mozharness: 2016-12-08 16:05:35.604774Z] Running clobber step. 08:05:35 INFO - Running pre-action listener: _resource_record_pre_action 08:05:35 INFO - Running main action method: clobber 08:05:35 INFO - rmtree: /builds/slave/test/build 08:05:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:36 INFO - Running post-action listener: _resource_record_post_action 08:05:36 INFO - [mozharness: 2016-12-08 16:05:36.064176Z] Finished clobber step (success) 08:05:36 INFO - [mozharness: 2016-12-08 16:05:36.064275Z] Running read-buildbot-config step. 08:05:36 INFO - Running pre-action listener: _resource_record_pre_action 08:05:36 INFO - Running main action method: read_buildbot_config 08:05:36 INFO - Using buildbot properties: 08:05:36 INFO - { 08:05:36 INFO - "project": "", 08:05:36 INFO - "product": "firefox", 08:05:36 INFO - "script_repo_revision": "production", 08:05:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:05:36 INFO - "repository": "", 08:05:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:05:36 INFO - "buildid": "20161208071558", 08:05:36 INFO - "pgo_build": "False", 08:05:36 INFO - "basedir": "/builds/slave/test", 08:05:36 INFO - "buildnumber": 858, 08:05:36 INFO - "slavename": "talos-linux64-ix-049", 08:05:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:05:36 INFO - "platform": "ubuntu64_hw", 08:05:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:05:36 INFO - "branch": "mozilla-central", 08:05:36 INFO - "repo_path": "mozilla-central", 08:05:36 INFO - "revision": "64e024fe44719575aa56c432e059ca065071ac95", 08:05:36 INFO - "stage_platform": "linux64", 08:05:36 INFO - "builduid": "d28ea995524547d7b09f62354ba63f7c", 08:05:36 INFO - "slavebuilddir": "test" 08:05:36 INFO - } 08:05:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:05:36 INFO - Running post-action listener: _resource_record_post_action 08:05:36 INFO - [mozharness: 2016-12-08 16:05:36.066708Z] Finished read-buildbot-config step (success) 08:05:36 INFO - [mozharness: 2016-12-08 16:05:36.066796Z] Running download-and-extract step. 08:05:36 INFO - Running pre-action listener: _resource_record_pre_action 08:05:36 INFO - Running main action method: download_and_extract 08:05:36 INFO - mkdir: /builds/slave/test/build/tests 08:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:36 INFO - trying https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:05:36 INFO - Downloading https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/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 08:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/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 08:05:36 INFO - Downloaded 1361 bytes. 08:05:36 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:05:36 INFO - Using the following test package requirements: 08:05:36 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:36 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:36 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:36 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'jsshell-linux-x86_64.zip'], 08:05:36 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:36 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:36 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:36 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:36 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:36 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:36 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:36 INFO - Fetch https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:05:37 INFO - Expected file size: 20218937 08:05:37 INFO - Obtained file size: 20218937 08:05:41 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 08:05:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:05:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:41 INFO - Fetch https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:05:42 INFO - Expected file size: 20218937 08:05:42 INFO - Obtained file size: 20218937 08:05:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:05:47 INFO - Expected file size: 14409734 08:05:47 INFO - Obtained file size: 14409734 08:05:47 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')]} 08:05:47 INFO - trying https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:05:47 INFO - Downloading https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/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 08:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/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 08:05:48 INFO - Downloaded 55708194 bytes. 08:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:05:48 INFO - mkdir: /builds/slave/test/properties 08:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:48 INFO - Contents: 08:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:05:49 INFO - Running post-action listener: _resource_record_post_action 08:05:49 INFO - Running post-action listener: set_extra_try_arguments 08:05:49 INFO - [mozharness: 2016-12-08 16:05:49.353969Z] Finished download-and-extract step (success) 08:05:49 INFO - [mozharness: 2016-12-08 16:05:49.354195Z] Running populate-webroot step. 08:05:49 INFO - Running pre-action listener: _resource_record_pre_action 08:05:49 INFO - Running main action method: populate_webroot 08:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:49 INFO - '--tppagecycles', 08:05:49 INFO - '7'], 08:05:49 INFO - 'tests': ['tsvgm']}}, 08:05:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['damp', 'tps']}, 08:05:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'tests': ['damp', 'tps']}, 08:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['dromaeo_dom']}, 08:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['basic_compositor_video']}, 08:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['a11yr', 08:05:49 INFO - 'ts_paint', 08:05:49 INFO - 'tpaint', 08:05:49 INFO - 'sessionrestore', 08:05:49 INFO - 'sessionrestore_no_auto_restore', 08:05:49 INFO - 'tabpaint']}, 08:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['tsvgx', 08:05:49 INFO - 'tsvgr_opacity', 08:05:49 INFO - 'tart', 08:05:49 INFO - 'tscrollx', 08:05:49 INFO - 'cart', 08:05:49 INFO - 'tsvg_static']}, 08:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:49 INFO - 'tsvgr_opacity', 08:05:49 INFO - 'tart', 08:05:49 INFO - 'tscrollx', 08:05:49 INFO - 'cart', 08:05:49 INFO - 'tsvg_static']}, 08:05:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'talos_options': ['--disable-e10s'], 08:05:49 INFO - 'tests': ['tp5o']}, 08:05:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:05:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'talos_options': ['--disable-e10s', 08:05:49 INFO - '--xperf_path', 08:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:49 INFO - 'tests': ['tp5n']}, 08:05:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:05:49 INFO - 'talos_options': ['--xperf_path', 08:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:49 INFO - 'tests': ['tp5n']}}, 08:05:49 INFO - 'talos.zip': {'path': '', 08:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:49 INFO - Running post-action listener: _resource_record_post_action 08:05:49 INFO - [mozharness: 2016-12-08 16:05:49.376363Z] Finished populate-webroot step (success) 08:05:49 INFO - [mozharness: 2016-12-08 16:05:49.376451Z] Running create-virtualenv step. 08:05:49 INFO - Running pre-action listener: _resource_record_pre_action 08:05:49 INFO - Running main action method: create_virtualenv 08:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:49 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 08:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:49 INFO - Using real prefix '/usr' 08:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:51 INFO - Installing pip.................done. 08:05:51 INFO - Return code: 0 08:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:05:52 INFO - Reading from file tmpfile_stdout 08:05:52 INFO - Output received: 08:05:52 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) 08:05:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:52 INFO - Using env: {'DISPLAY': ':0', 08:05:52 INFO - 'HOME': '/home/cltbld', 08:05:52 INFO - 'LANG': 'en_US.UTF-8', 08:05:52 INFO - 'LANGUAGE': 'en_US:en', 08:05:52 INFO - 'LOGNAME': 'cltbld', 08:05:52 INFO - 'MAIL': '/var/mail/cltbld', 08:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:52 INFO - 'MOZ_NO_REMOTE': '1', 08:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:52 INFO - 'NO_EM_RESTART': '1', 08:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:52 INFO - 'PWD': '/builds/slave/test', 08:05:52 INFO - 'SHELL': '/bin/bash', 08:05:52 INFO - 'SHLVL': '1', 08:05:52 INFO - 'TERM': 'linux', 08:05:52 INFO - 'TMOUT': '86400', 08:05:52 INFO - 'USER': 'cltbld', 08:05:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:52 INFO - '_': '/tools/buildbot/bin/python'} 08:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:52 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 08:05:52 INFO - Cleaning up... 08:05:52 INFO - Return code: 0 08:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:52 INFO - Using env: {'DISPLAY': ':0', 08:05:52 INFO - 'HOME': '/home/cltbld', 08:05:52 INFO - 'LANG': 'en_US.UTF-8', 08:05:52 INFO - 'LANGUAGE': 'en_US:en', 08:05:52 INFO - 'LOGNAME': 'cltbld', 08:05:52 INFO - 'MAIL': '/var/mail/cltbld', 08:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:52 INFO - 'MOZ_NO_REMOTE': '1', 08:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:52 INFO - 'NO_EM_RESTART': '1', 08:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:52 INFO - 'PWD': '/builds/slave/test', 08:05:52 INFO - 'SHELL': '/bin/bash', 08:05:52 INFO - 'SHLVL': '1', 08:05:52 INFO - 'TERM': 'linux', 08:05:52 INFO - 'TMOUT': '86400', 08:05:52 INFO - 'USER': 'cltbld', 08:05:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:52 INFO - '_': '/tools/buildbot/bin/python'} 08:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:52 INFO - Downloading/unpacking psutil>=3.1.1 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:54 INFO - Installing collected packages: psutil 08:05:54 INFO - Running setup.py install for psutil 08:05:54 INFO - building 'psutil._psutil_linux' extension 08:05:54 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 08:05:54 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 08:05:54 INFO - building 'psutil._psutil_posix' extension 08:05:54 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 08:05:55 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 08:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:55 INFO - Successfully installed psutil 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:05:55 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 08:05:55 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 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:57 INFO - Installing collected packages: mozsystemmonitor 08:05:57 INFO - Running setup.py install for mozsystemmonitor 08:05:57 INFO - Successfully installed mozsystemmonitor 08:05:57 INFO - Cleaning up... 08:05:57 INFO - Return code: 0 08:05:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:57 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')]} 08:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 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')]} 08:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:05:57 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 08:05:57 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 08:05:57 INFO - Using env: {'DISPLAY': ':0', 08:05:57 INFO - 'HOME': '/home/cltbld', 08:05:57 INFO - 'LANG': 'en_US.UTF-8', 08:05:57 INFO - 'LANGUAGE': 'en_US:en', 08:05:57 INFO - 'LOGNAME': 'cltbld', 08:05:57 INFO - 'MAIL': '/var/mail/cltbld', 08:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:57 INFO - 'MOZ_NO_REMOTE': '1', 08:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:57 INFO - 'NO_EM_RESTART': '1', 08:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:57 INFO - 'PWD': '/builds/slave/test', 08:05:57 INFO - 'SHELL': '/bin/bash', 08:05:57 INFO - 'SHLVL': '1', 08:05:57 INFO - 'TERM': 'linux', 08:05:57 INFO - 'TMOUT': '86400', 08:05:57 INFO - 'USER': 'cltbld', 08:05:57 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:57 INFO - '_': '/tools/buildbot/bin/python'} 08:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:59 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 08:05:59 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 08:05:59 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 08:05:59 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 08:05:59 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 08:05:59 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 08:06:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:00 INFO - warning: no files found matching '*.txt' 08:06:00 INFO - no previously-included directories found matching 'build' 08:06:00 INFO - no previously-included directories found matching 'dist' 08:06:00 INFO - no previously-included directories found matching '.git*' 08:06:00 INFO - Installing collected packages: jsonschema, functools32 08:06:00 INFO - Running setup.py install for functools32 08:06:00 INFO - warning: no files found matching '*.txt' 08:06:00 INFO - no previously-included directories found matching 'build' 08:06:00 INFO - no previously-included directories found matching 'dist' 08:06:00 INFO - no previously-included directories found matching '.git*' 08:06:00 INFO - Successfully installed jsonschema functools32 08:06:00 INFO - Cleaning up... 08:06:00 INFO - Return code: 0 08:06:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:06:00 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')]} 08:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:00 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')]} 08:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:00 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:00 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 08:06:00 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 08:06:00 INFO - Using env: {'DISPLAY': ':0', 08:06:00 INFO - 'HOME': '/home/cltbld', 08:06:00 INFO - 'LANG': 'en_US.UTF-8', 08:06:00 INFO - 'LANGUAGE': 'en_US:en', 08:06:00 INFO - 'LOGNAME': 'cltbld', 08:06:00 INFO - 'MAIL': '/var/mail/cltbld', 08:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:00 INFO - 'MOZ_NO_REMOTE': '1', 08:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:00 INFO - 'NO_EM_RESTART': '1', 08:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:00 INFO - 'PWD': '/builds/slave/test', 08:06:00 INFO - 'SHELL': '/bin/bash', 08:06:00 INFO - 'SHLVL': '1', 08:06:00 INFO - 'TERM': 'linux', 08:06:00 INFO - 'TMOUT': '86400', 08:06:00 INFO - 'USER': 'cltbld', 08:06:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:00 INFO - '_': '/tools/buildbot/bin/python'} 08:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:06:00 INFO - Cleaning up... 08:06:00 INFO - Return code: 0 08:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:00 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')]} 08:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:00 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')]} 08:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:00 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:00 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 08:06:00 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 08:06:00 INFO - Using env: {'DISPLAY': ':0', 08:06:00 INFO - 'HOME': '/home/cltbld', 08:06:00 INFO - 'LANG': 'en_US.UTF-8', 08:06:00 INFO - 'LANGUAGE': 'en_US:en', 08:06:00 INFO - 'LOGNAME': 'cltbld', 08:06:00 INFO - 'MAIL': '/var/mail/cltbld', 08:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:00 INFO - 'MOZ_NO_REMOTE': '1', 08:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:00 INFO - 'NO_EM_RESTART': '1', 08:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:00 INFO - 'PWD': '/builds/slave/test', 08:06:00 INFO - 'SHELL': '/bin/bash', 08:06:00 INFO - 'SHLVL': '1', 08:06:00 INFO - 'TERM': 'linux', 08:06:00 INFO - 'TMOUT': '86400', 08:06:00 INFO - 'USER': 'cltbld', 08:06:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:00 INFO - '_': '/tools/buildbot/bin/python'} 08:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:02 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 08:06:02 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 08:06:02 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 08:06:02 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 08:06:02 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 08:06:02 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 08:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:03 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 08:06:03 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 08:06:03 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 08:06:03 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 08:06:03 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 08:06:03 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 08:06:03 INFO - Downloading docopt-0.6.1.tar.gz 08:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:03 INFO - Running setup.py install for blobuploader 08:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:03 INFO - Running setup.py install for requests 08:06:03 INFO - Running setup.py install for docopt 08:06:04 INFO - Successfully installed blobuploader requests docopt 08:06:04 INFO - Cleaning up... 08:06:04 INFO - Return code: 0 08:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:04 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')]} 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:04 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')]} 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:04 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:04 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 08:06:04 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 08:06:04 INFO - Using env: {'DISPLAY': ':0', 08:06:04 INFO - 'HOME': '/home/cltbld', 08:06:04 INFO - 'LANG': 'en_US.UTF-8', 08:06:04 INFO - 'LANGUAGE': 'en_US:en', 08:06:04 INFO - 'LOGNAME': 'cltbld', 08:06:04 INFO - 'MAIL': '/var/mail/cltbld', 08:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:04 INFO - 'MOZ_NO_REMOTE': '1', 08:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:04 INFO - 'NO_EM_RESTART': '1', 08:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:04 INFO - 'PWD': '/builds/slave/test', 08:06:04 INFO - 'SHELL': '/bin/bash', 08:06:04 INFO - 'SHLVL': '1', 08:06:04 INFO - 'TERM': 'linux', 08:06:04 INFO - 'TMOUT': '86400', 08:06:04 INFO - 'USER': 'cltbld', 08:06:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:04 INFO - '_': '/tools/buildbot/bin/python'} 08:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:04 INFO - Running setup.py (path:/tmp/pip-JRPXhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:04 INFO - Running setup.py (path:/tmp/pip-7ZTct2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:04 INFO - Running setup.py (path:/tmp/pip-MtfOLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:04 INFO - Running setup.py (path:/tmp/pip-1ulS8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:04 INFO - Running setup.py (path:/tmp/pip-xsUkkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:04 INFO - Running setup.py (path:/tmp/pip-VKkoQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:04 INFO - Running setup.py (path:/tmp/pip-bzp7zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:04 INFO - Running setup.py (path:/tmp/pip-zbpqcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:04 INFO - Running setup.py (path:/tmp/pip-sRODs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:05 INFO - Running setup.py (path:/tmp/pip-eb2ZQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:05 INFO - Running setup.py (path:/tmp/pip-uI95Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:05 INFO - Running setup.py (path:/tmp/pip-ZtKUu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:05 INFO - Running setup.py (path:/tmp/pip-gBzJvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:05 INFO - Running setup.py (path:/tmp/pip-Nmscdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:05 INFO - Running setup.py (path:/tmp/pip-6fpSbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:05 INFO - Running setup.py (path:/tmp/pip-L9WjOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:05 INFO - Running setup.py (path:/tmp/pip-FASdbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:05 INFO - Running setup.py install for manifestparser 08:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:05 INFO - Running setup.py install for mozcrash 08:06:05 INFO - Running setup.py install for mozdebug 08:06:05 INFO - Running setup.py install for mozdevice 08:06:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozfile 08:06:06 INFO - Running setup.py install for mozhttpd 08:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozinfo 08:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozInstall 08:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozleak 08:06:06 INFO - Running setup.py install for mozlog 08:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for moznetwork 08:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozprocess 08:06:06 INFO - Running setup.py install for mozprofile 08:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:06 INFO - Running setup.py install for mozrunner 08:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:07 INFO - Running setup.py install for mozscreenshot 08:06:07 INFO - Running setup.py install for moztest 08:06:07 INFO - Running setup.py install for mozversion 08:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:07 INFO - Cleaning up... 08:06:07 INFO - Return code: 0 08:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:07 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:07 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 08:06:07 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 08:06:07 INFO - Using env: {'DISPLAY': ':0', 08:06:07 INFO - 'HOME': '/home/cltbld', 08:06:07 INFO - 'LANG': 'en_US.UTF-8', 08:06:07 INFO - 'LANGUAGE': 'en_US:en', 08:06:07 INFO - 'LOGNAME': 'cltbld', 08:06:07 INFO - 'MAIL': '/var/mail/cltbld', 08:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:07 INFO - 'MOZ_NO_REMOTE': '1', 08:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:07 INFO - 'NO_EM_RESTART': '1', 08:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:07 INFO - 'PWD': '/builds/slave/test', 08:06:07 INFO - 'SHELL': '/bin/bash', 08:06:07 INFO - 'SHLVL': '1', 08:06:07 INFO - 'TERM': 'linux', 08:06:07 INFO - 'TMOUT': '86400', 08:06:07 INFO - 'USER': 'cltbld', 08:06:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:07 INFO - '_': '/tools/buildbot/bin/python'} 08:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:07 INFO - Running setup.py (path:/tmp/pip-_Tsa_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:07 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)) 08:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:07 INFO - Running setup.py (path:/tmp/pip-EgAhjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:07 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)) 08:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:07 INFO - Running setup.py (path:/tmp/pip-EnLOvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:07 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)) 08:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:07 INFO - Running setup.py (path:/tmp/pip-5qyINf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:07 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)) 08:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:07 INFO - Running setup.py (path:/tmp/pip-WGKakX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:08 INFO - Running setup.py (path:/tmp/pip-k2atsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:08 INFO - Running setup.py (path:/tmp/pip-SRg8ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:08 INFO - Running setup.py (path:/tmp/pip-sHn4FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:08 INFO - Running setup.py (path:/tmp/pip-MYcSN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:08 INFO - Running setup.py (path:/tmp/pip-Z57aNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:08 INFO - Running setup.py (path:/tmp/pip-oG2jE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:08 INFO - Running setup.py (path:/tmp/pip-X8hc2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:08 INFO - Running setup.py (path:/tmp/pip-Z7UrSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:08 INFO - Running setup.py (path:/tmp/pip-VSwqmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:08 INFO - Running setup.py (path:/tmp/pip-tM72NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:08 INFO - Running setup.py (path:/tmp/pip-dWQLkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:08 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)) 08:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:08 INFO - Running setup.py (path:/tmp/pip-rUFxeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:08 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)) 08:06:08 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)) 08:06:08 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)) 08:06:08 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)) 08:06:08 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)) 08:06:08 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)) 08:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:08 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 08:06:08 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 08:06:08 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 08:06:08 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 08:06:08 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 08:06:08 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 08:06:10 INFO - Downloading blessings-1.6.tar.gz 08:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:10 INFO - Installing collected packages: blessings 08:06:10 INFO - Running setup.py install for blessings 08:06:11 INFO - Successfully installed blessings 08:06:11 INFO - Cleaning up... 08:06:11 INFO - Return code: 0 08:06:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:11 INFO - Reading from file tmpfile_stdout 08:06:11 INFO - Current package versions: 08:06:11 INFO - argparse == 1.2.1 08:06:11 INFO - blessings == 1.6 08:06:11 INFO - blobuploader == 1.2.4 08:06:11 INFO - docopt == 0.6.1 08:06:11 INFO - functools32 == 3.2.3-2 08:06:11 INFO - jsonschema == 2.5.1 08:06:11 INFO - manifestparser == 1.1 08:06:11 INFO - mozInstall == 1.12 08:06:11 INFO - mozcrash == 1.0 08:06:11 INFO - mozdebug == 0.1 08:06:11 INFO - mozdevice == 0.49 08:06:11 INFO - mozfile == 1.2 08:06:11 INFO - mozhttpd == 0.7 08:06:11 INFO - mozinfo == 0.9 08:06:11 INFO - mozleak == 0.1 08:06:11 INFO - mozlog == 3.4 08:06:11 INFO - moznetwork == 0.27 08:06:11 INFO - mozprocess == 0.23 08:06:11 INFO - mozprofile == 0.28 08:06:11 INFO - mozrunner == 6.13 08:06:11 INFO - mozscreenshot == 0.1 08:06:11 INFO - mozsystemmonitor == 0.3 08:06:11 INFO - moztest == 0.7 08:06:11 INFO - mozversion == 1.4 08:06:11 INFO - psutil == 3.1.1 08:06:11 INFO - requests == 1.2.3 08:06:11 INFO - wsgiref == 0.1.2 08:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:11 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 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:11 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 08:06:11 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 08:06:11 INFO - Using env: {'DISPLAY': ':0', 08:06:11 INFO - 'HOME': '/home/cltbld', 08:06:11 INFO - 'LANG': 'en_US.UTF-8', 08:06:11 INFO - 'LANGUAGE': 'en_US:en', 08:06:11 INFO - 'LOGNAME': 'cltbld', 08:06:11 INFO - 'MAIL': '/var/mail/cltbld', 08:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:11 INFO - 'MOZ_NO_REMOTE': '1', 08:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:11 INFO - 'NO_EM_RESTART': '1', 08:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:11 INFO - 'PWD': '/builds/slave/test', 08:06:11 INFO - 'SHELL': '/bin/bash', 08:06:11 INFO - 'SHLVL': '1', 08:06:11 INFO - 'TERM': 'linux', 08:06:11 INFO - 'TMOUT': '86400', 08:06:11 INFO - 'USER': 'cltbld', 08:06:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:11 INFO - '_': '/tools/buildbot/bin/python'} 08:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 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)) 08:06:11 INFO - Cleaning up... 08:06:11 INFO - Return code: 0 08:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac607ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, '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': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', '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 08:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:06:11 INFO - Using env: {'DISPLAY': ':0', 08:06:11 INFO - 'HOME': '/home/cltbld', 08:06:11 INFO - 'LANG': 'en_US.UTF-8', 08:06:11 INFO - 'LANGUAGE': 'en_US:en', 08:06:11 INFO - 'LOGNAME': 'cltbld', 08:06:11 INFO - 'MAIL': '/var/mail/cltbld', 08:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:11 INFO - 'MOZ_NO_REMOTE': '1', 08:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:11 INFO - 'NO_EM_RESTART': '1', 08:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:11 INFO - 'PWD': '/builds/slave/test', 08:06:11 INFO - 'SHELL': '/bin/bash', 08:06:11 INFO - 'SHLVL': '1', 08:06:11 INFO - 'TERM': 'linux', 08:06:11 INFO - 'TMOUT': '86400', 08:06:11 INFO - 'USER': 'cltbld', 08:06:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:11 INFO - '_': '/tools/buildbot/bin/python'} 08:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:06:11 INFO - Cleaning up... 08:06:11 INFO - Return code: 0 08:06:11 INFO - Running post-action listener: _resource_record_post_action 08:06:11 INFO - Running post-action listener: _start_resource_monitoring 08:06:11 INFO - Starting resource monitoring. 08:06:11 INFO - [mozharness: 2016-12-08 16:06:11.836664Z] Finished create-virtualenv step (success) 08:06:11 INFO - [mozharness: 2016-12-08 16:06:11.837183Z] Running install step. 08:06:11 INFO - Running pre-action listener: _resource_record_pre_action 08:06:11 INFO - Running main action method: install 08:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:12 INFO - Reading from file tmpfile_stdout 08:06:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:12 INFO - Reading from file tmpfile_stdout 08:06:12 INFO - Output received: 08:06:12 INFO - Usage: mozinstall [options] installer 08:06:12 INFO - Options: 08:06:12 INFO - -h, --help show this help message and exit 08:06:12 INFO - -d DEST, --destination=DEST 08:06:12 INFO - Directory to install application into. [default: 08:06:12 INFO - "/builds/slave/test"] 08:06:12 INFO - --app=APP Application being installed. [default: firefox] 08:06:12 INFO - mkdir: /builds/slave/test/build/application 08:06:12 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'] 08:06:12 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 08:06:28 INFO - Reading from file tmpfile_stdout 08:06:28 INFO - Output received: 08:06:28 INFO - /builds/slave/test/build/application/firefox/firefox 08:06:28 INFO - Running post-action listener: _resource_record_post_action 08:06:28 INFO - [mozharness: 2016-12-08 16:06:28.171751Z] Finished install step (success) 08:06:28 INFO - [mozharness: 2016-12-08 16:06:28.171993Z] Running run-tests step. 08:06:28 INFO - Running pre-action listener: _resource_record_pre_action 08:06:28 INFO - Running main action method: run_tests 08:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:28 INFO - Python 2.7.3 08:06:28 INFO - Return code: 0 08:06:28 INFO - grabbing minidump binary from tooltool 08:06: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')]} 08:06:28 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 0x153cf20>, '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 0x14a9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:28 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 08:06:28 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 08:06:28 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 08:06:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:28 INFO - Return code: 0 08:06:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:06:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:06:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 08:06:28 INFO - Using env: {'DISPLAY': ':0', 08:06:28 INFO - 'HOME': '/home/cltbld', 08:06:28 INFO - 'LANG': 'en_US.UTF-8', 08:06:28 INFO - 'LANGUAGE': 'en_US:en', 08:06:28 INFO - 'LOGNAME': 'cltbld', 08:06:28 INFO - 'MAIL': '/var/mail/cltbld', 08:06:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:28 INFO - 'MOZ_NO_REMOTE': '1', 08:06:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:28 INFO - 'NO_EM_RESTART': '1', 08:06:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:28 INFO - 'PWD': '/builds/slave/test', 08:06:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:28 INFO - 'SHELL': '/bin/bash', 08:06:28 INFO - 'SHLVL': '1', 08:06:28 INFO - 'TERM': 'linux', 08:06:28 INFO - 'TMOUT': '86400', 08:06:28 INFO - 'USER': 'cltbld', 08:06:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095', 08:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:28 INFO - '_': '/tools/buildbot/bin/python'} 08:06:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:06:28 INFO - mozversion application_buildid: 20161208071558 08:06:28 INFO - mozversion application_changeset: 64e024fe44719575aa56c432e059ca065071ac95 08:06:28 INFO - mozversion application_display_name: Nightly 08:06:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:28 INFO - mozversion application_name: Firefox 08:06:28 INFO - mozversion application_remotingname: firefox 08:06:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:06:28 INFO - mozversion application_vendor: Mozilla 08:06:28 INFO - mozversion application_version: 53.0a1 08:06:28 INFO - mozversion platform_buildid: 20161208071558 08:06:28 INFO - mozversion platform_changeset: 64e024fe44719575aa56c432e059ca065071ac95 08:06:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:06:28 INFO - mozversion platform_version: 53.0a1 08:06:28 INFO - using testdate: 1481213188 08:06:28 INFO - actual date: 1481213188 08:06:28 INFO - starting webserver on 'localhost:58246' 08:06:28 INFO - SUITE-START | Running 2 tests 08:06:28 INFO - TEST-START | dromaeo_css 08:06:28 INFO - operating with platform_type : linux_ 08:06:28 INFO - Initialising browser for dromaeo_css test... 08:06:28 INFO - TEST-INFO | started process 12510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXjxWbW/profile http://localhost:58246/getInfo.html) 08:06:32 INFO - PROCESS | 12510 | __metrics Screen width/height:1600/1200 08:06:32 INFO - PROCESS | 12510 | colorDepth:24 08:06:32 INFO - PROCESS | 12510 | Browser inner width/height: 1024/697 08:06:32 INFO - PROCESS | 12510 | __metrics 08:06:33 INFO - PROCESS | 12510 | 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" 08:06:33 INFO - PROCESS | 12510 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:34 INFO - PROCESS | 12510 | console.error: PushService: 08:06:34 INFO - PROCESS | 12510 | stateChangeProcessEnqueue: Error transitioning state 08:06:34 INFO - PROCESS | 12510 | UnknownError 08:06:34 INFO - TEST-INFO | 12510: exit 0 08:06:34 INFO - Browser initialized. 08:06:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:34 INFO - TEST-INFO | started process 12591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXjxWbW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:47 INFO - PROCESS | 12591 | RSS: Main: 173162496 08:06:47 INFO - PROCESS | 12591 | 08:07:38 INFO - PROCESS | 12591 | 1481213258019 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] 08:09:51 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58246/tests/dromaeo/cssquery-ext.html) 08:09:54 INFO - PROCESS | 12591 | RSS: Main: 389525504 08:09:54 INFO - PROCESS | 12591 | 08:12:56 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-ext.html (next: http://localhost:58246/tests/dromaeo/cssquery-jquery.html) 08:12:57 INFO - PROCESS | 12591 | RSS: Main: 284151808 08:12:57 INFO - PROCESS | 12591 | 08:16:00 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58246/tests/dromaeo/cssquery-mootools.html) 08:16:00 INFO - PROCESS | 12591 | RSS: Main: 221057024 08:16:00 INFO - PROCESS | 12591 | 08:19:03 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58246/tests/dromaeo/cssquery-prototype.html) 08:19:03 INFO - PROCESS | 12591 | RSS: Main: 220950528 08:19:03 INFO - PROCESS | 12591 | 08:22:06 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58246/tests/dromaeo/cssquery-yui.html) 08:22:07 INFO - PROCESS | 12591 | RSS: Main: 220565504 08:22:07 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | Cycle 1(1): loaded http://localhost:58246/tests/dromaeo/cssquery-yui.html (next: http://localhost:58246/tests/dromaeo/cssquery-dojo.html) 08:25:10 INFO - PROCESS | 12591 | RSS: Main: 313532416 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | __start_tp_report 08:25:10 INFO - PROCESS | 12591 | _x_x_mozilla_page_load 08:25:10 INFO - PROCESS | 12591 | _x_x_mozilla_page_load_details 08:25:10 INFO - PROCESS | 12591 | |i|pagename|runs| 08:25:10 INFO - PROCESS | 12591 | |0;dojo.html;2561.462092960478;2604.0365064925954;2604.6874375074995;2636.7890568754488;2646.7220941801124;4545.863624091283;4583;4692.624590032793;4703.69425987311;4725.196716558185;4640.837570685027;4678.602318802898;4705.717656940586;4738.47876733559;4787.162246606838;4248.362745588156;4268.615824575788;4306.332518459628;4335.848245311415;4401.66987475939;3971.872561646284;4286.507051689065;4323.286657701476;4363.367311739796;4400.295952647577;4196.685248606367;4374.606285434326;4376.846810361654;4440.4893437254805;4467.530909254514;4233.724807887508;4268.381084742695;4287.742735435852;4295.119500502421;4301.548337424588;4255.468066491689;4285.914281714348;4287.078278170208;4290.313549832012;4291.034517233597;4660.930086048712;4677.672562920597;4680.531946805327;4709.6467764917425;4738.336632871401;5016.247562865563;5017.949820501784;5025.673331233458;5032.345795046657;5079.288899554065;4846.61227101831;4895.804167833282;5038.874028149289;5039.168537191359;5089.949100508985;4602.815887364468;4610.585047345755;4658.464276608233;4658.464276608233;4716.8113275468595;5068.670536415121;5107.897842043139;5110.693358398508;5116.897662046813;5169.25045868347;4907.067657145131;4920.852374428773;4922.409310882717;4925.064237794808;4967.7019378837385;4872.829450969199;4918.2376731606655;4919.606431485473;4921.753912304371;4925.802967881316;4909.459959404463;4913.656044076952;4920.729359885169;4927.679700819507;4956.504349565087;4887.144749668793;4890.266460030953;4890.828820991248;4893.486183950705;4939.333190019373;4104.445899803548;4140.896477588084;4144.606262405066;4182.1008483176265;4187.434696315959;3660.048387419237;3692.095436618046;3696.8890933272046;3701.130234394915;3750.9624903750614;4300.78496075195;4301.096769678403;4303.892402689958;4337.067530480962;4339.5660433956355;4932.21084626458;5032.094223039888;5034;5040.067587496252;5042.647014708935;4248.9787551062045;4254.468191476066;4257.169851878916;4267.679924005712;4322.762248076323;4508.256137737302;4513.887152821206;4514.345419914094;4556.384888040072;4559.566841150086;4674;4679.953200467951;4695.694779839299;4696.272077827942;4720.244760838249;4860.95139048605;4949.653524253267;4949.851504454872;5017.64876458659;5022.598192144693;4674.345591617244;4675.298705194248;4688.5545873142;4689.648276379217;4690.835820746258;4938.901221975612;4941.135301322182;4941.357623508921;4944.579710724629;4945.134601444661;5008.449070602303;5014.498550144956;5014.924776128288;5021.1213037717525;5021.7740201690285;4845.878853028703;4878.731669758197;4888.560029597354;4889.853304400874;4890.804367825247;4834.830780922651;4854.320395144753;4855.441624213261;4855.830045948375;4856.174450343521;4796.880077998078;4798.568128868279;4801.063792560417;4827.831025914076;4829.95170048295;4959.70241785494;4973.104841128632;4975.825846095369;4976.701397916137;5027.874303142451;4688.296755486705;4728.456227533878;4838.274258861199;4847.491013443538;4894.167991441393 08:25:10 INFO - PROCESS | 12591 | |1;ext.html;554.595145543753;590.8138936235085;608.1637748096367;611.4863514647695;611.4924612571568;35970.460443093376;37604.623953760456;37713.43429848555;41632;41643.16713665725;38899.805500972456;39280.60719392805;39293;39353.60646393535;39405.21189576207;7202.135743710762;7385.889211661829;7400.333969942718;7538.773836784878;7544.962275188616;9205;9513.857292140623;9522.952385238064;9787.951060244688;9799.90200097997;9701.902980970206;9780.46207458593;9781.315307928448;9781.315307928448;9781.510924453785;9844.901550984507;9861.704148875546;9895.901040989569;9906.851397228975;9910.752231194207;9714.22286217101;9761.463119528424;9773.21814254858;9778.462184579845;9781.608735650565;37480.25039499222;37714.811425942695;37813.432798508045;37857.621423785684;37868.62131378678;3045.9086227413213;3133.4359815233247;3271.4275001874576;3337.4159522083537;3647.544056992876;27191;27270.45459090827;27473.17580472589;27491.86254068737;27545;3434.3818112739696;3467.8092704901474;3614.4036234021355;3687.539057617798;3691.187938653492;248523;249601;250308;250965;251373;49760;49976.500234997184;50058.24912626314;50061.74969125204;50086.248706269434;53340.73329633327;53379.19931201035;53385;53455.46544534583;53573;13602.455901764017;13836.723265534632;13968.930155349159;13975.440982360795;13981.161130332213;9028.277737780962;9253.167214950687;9485.288603354638;9885.604575817031;10272.743181420525;15027.774583381259;15209.847901520843;15275.083494990336;15276.847231527543;15378.3079761411;5869.618474799125;5937.584369094208;5979.581429299994;5981.790637327673;6099;753.9660715267717;827.9337652987747;896.6816780043122;976.2141476111798;991.6677912899115;25874.482510349688;27302.180934571996;27552;27797;27895.302617434725;900.7928176519306;936.765808547863;936.8828896387952;970.0735797313548;1010.2625083688948;13616.65958351049;14244.287785610679;14482.420703171754;14545.34545945435;14803.851961480463;350801;351306;351402;352592;353058;47748.761256193495;47924.28113578299;47945.5205447948;47995.280070798966;47996;1070.4219721350385;1092.2790957967861;1127.537709539085;1135.1486385211092;1184.040926849255;24908;27796.722032779413;28121.578176326962;28331;28426.773512114396;35659.82170089133;35837.82081089578;35860.462093068105;35897.64102359048;35916.28167436689;282946;283318;284225.26057939365;284589;284837;23564.293071207892;23979.880100599385;25426.364340891625;34014;34239.14402139966;37027.62972370242;37153.81423092867;37291.44062839005;37397.626023739416;37424.812875935444;32510.512342315356;32891.34217315688;33179.668203317655;33316.1670958228;33506.83246583751;32405.18987025343;32473.51289730703;32589.511157332185;32733.50899736458;32976.67023329736;32265.193370165933;32673.673263267065;32740.181495462803;32970.340593187524;33153.33693326168;27467.450650987266;29032.274193145342;30057.849710751307;30198.396032079676;30543.2364190897;23029;23209.88395058014;23820.285391438283;23831.404214894766;24000.399989999692 08:25:10 INFO - PROCESS | 12591 | |2;jquery.html;345.2921510902649;358.7363287983333;369.59529315399635;370.3167655675279;389.6240128276213;12322.568710095149;15263.313150908209;15296.158711270875;16016.839831601681;16932.576685582866;16122.274497647604;16163.272652730626;16351.345946162139;16441.67116657666;16682.41611543596;4759.214729569617;4764.928526072112;4923.950760492403;4940.1601727706375;4959.181735013718;3656.7074634029345;3821.866234681787;4855.902881942359;4903.485134060926;4948.653594248404;3862.304785138674;3871.032241939515;3884.747491413063;5562.7774889004395;5857.8828423431505;5621.156826476021;5731.283589551306;5893.469587737103;5912.911306330366;5915.438033386843;5037.672551284155;5041.8487445376695;5044.117279476113;5045.520675535819;5046.0664777016;19601.509962250915;19765.505862353555;19797.109130089037;19863.106160222826;19937.202511899508;1846.5291350705618;1934.8258656720964;2076.0559890994673;2212.3362991102604;2283.315005498344;11985;12665.176763510342;13054.934725326313;13150.408231629504;13404.530841420601;1757.314647287559;1789.4363275568155;1821.9180136893872;1903.1626084522766;1909.255390397746;73233;76300.61849690771;77624.40192583637;79397.53254284048;80460.19539804645;8214.8357032859;8264;8647.135286471428;8686.174813392718;9157.771055723528;11879.703007424883;11932.343721095423;11960.820587691192;11981;11982.161248712506;6765.797026089225;6885.965570172117;6917.827054323682;7129.500934934505;7147.463940204506;6398.936010639927;6580.506462015368;6679.332066793282;7027.086478757728;7086.326798954091;3791.109089363997;3798.582155962842;3805.257974694963;3811.3411125320004;3855.9036024099623;1850.5651171974575;1864.4499872537633;1898.734177215191;1907.9663335296943;1910.3313840156113;716.3874886971564;797.9002624671916;870.3472395703222;884.7036242858586;918.1094338491653;15447.922760386351;15968.680626387408;16715.6656866862;16780.412685555948;17057.737412046557;829.4323728153794;831.264331066998;834.4576025583419;838.8070743728977;854.6410507586828;8720.30237580992;9590.08894155054;9591.273570757192;9602.135807777333;9749.805003899883;251482;321329;322333;323161;323247;50371.74814125979;60814.695926520086;69019;76947;80682;880.2561835249204;886.9423487473293;896.3008853094597;911.098012967171;913.196387179278;15226.543203703906;15316.540503784905;15916.920415397848;15985.120818355103;16178.110203938897;36203.27593448063;36211.81894090513;36402.27195456129;37447.2510549782;37924.62075379211;48281.5171848277;51337;51891.22163167631;52002;53094;6968.198657154289;7069.540479868998;7112.57324560528;7166.814121692725;7232.385247253832;10177.796444071226;11746.941265293619;11978.161528692908;12074;12293.385330733248;9944.403335799585;10136.189104871444;10216.284860060021;10639.680809575726;10805.45972701346;9720.222382209266;9975.251856110675;9986.60053597848;10117.949410252902;10250.58997640086;9933.205343572641;10198.18414526851;10573.577056917944;10929.344239345664;11000.394978275952;7058.435325174077;7118.359347658736;7241;7272.96363518179;7452.590107544137;10225.948870255601;10266.691999240034;10345.84481232767;10469.057784799405;10536.420496872746 08:25:10 INFO - PROCESS | 12591 | |3;mootools.html;1310.2858941876677;1324.1988596898875;1414.7524183267926;1643.7205675035257;1667.4997500749764;6360.586561873475;6602.834929126774;6892.724291028353;7320.048393708824;7342.568199201158;6854.21176564694;7174.6412679366085;7203.06360173178;7208.135023797152;7380.55716657001;2056.91772329107;2113.4399384163207;2116.100657220683;2116.904739286736;2118.3433135727896;1832.7709036370454;1890.8298253157213;2072.5077943880383;2094.4030951178916;2151.0535364439675;2059.227789578908;2117.8093971542557;2120.5122821751006;2129.3292612826986;2132.253711201075;2093.16273490605;2096.486360841596;2114.38682781993;2125.3517677108475;2127.244828086038;2172.587208430409;2176.5102851858364;2193.5393567350875;2197.835162362829;2199.48312146647;7164.892526612053;7331.193568707438;7331.413486921034;7333.083364579427;7333.230010848891;4341.5441378655105;4488.798004089824;4494.483134439549;4498.977505112453;4499.730016199039;2866.784991125674;2912.7524160446387;2987.0889378739475;2992.341684829334;2994.086803524924;935.7988032573029;949.2595775295281;957.5451660461295;986.531397586148;1002.0630710285833;9524.380915240487;9777;9818.9509052455;9819.312648114706;9837.065478779505;4176.582341765799;4333.501647310537;4346.413234213341;4355.4337936068105;4371.0820727646915;7674.693012279558;7723.729669461542;7725.497842640323;7734.613269336511;7745.457817952802;4558;4558.247889098262;4559.52125026874;4560.3843481129625;4565.292379681155;4165.58344165581;4172.165566886635;4179.038821071171;4212.978935105366;4267.722598031118;3159.1154476746547;3208.8235147066666;3250.447423937936;3270.427675156838;3295.884644037495;953.4851180362665;954.289054654287;977.53567055648;977.7995510920244;986.2356673578034;689.7344522358928;743.7880204141794;812.9105798362175;836.193073683898;858.6222062292571;4879.072766257308;4892.755362231946;5050.696958182521;5150.244619128748;5297.788088476418;798.2120051085527;824.6824972385555;851.7700220940311;863.7106569299355;882.8543290357147;3514.3674138655288;3525.206828463575;3562.4478205877613;3567.4292113261754;3719.497867787868;8581.313494920392;8919.509426981578;8931.553422328987;8934.776630584287;8935.508547029845;8876.556172191495;8889.422187557788;8892.59983300753;8895.911040889638;8897.644094236159;6651.368120028589;6796.116504854337;6813.148356455443;6819.624920629413;6821.283765204681;4727.834525791718;4871.537203965618;4901.14230009754;4953.028183090261;5091.287219789158;7969.083555391204;8012.118666946748;8024.598770061591;8048.839023219386;8058.3956203283815;8074.192580741878;8077.27304542594;8137.349012078901;8140.430169888051;8168;5882;6009.609375390761;6010.248718910137;6012.819615411545;6016.217891674054;6526.347365263626;6770.289119642367;6792.524523283323;6897.965510172417;6977.267386924503;5050.3182070420025;5912.822615321547;5967.791127310524;5971.134185543159;6093.086037094294;5911.3201981772645;5948.286205655176;5995.16067750524;6090.665013424305;6117.480014198843;5778.682172480386;5790.305163380422;5950.910736338872;6014.308354539109;6101.5118790497545;4302.655787536927;4312.460942382202;4435.733855968652;4436.600705936481;4544.068465964536;4360.454943132108;4422.314541246112;4510.345999830072;4553.791411165648;4574.6569007323915 08:25:10 INFO - PROCESS | 12591 | |4;prototype.html;291.55974478537416;297.7692288476431;304.9252933031409;305.25213227592377;306.0619202145424;4725.29120631905;4727.645426593002;4728.432588089429;4742.383490146281;4748.667593268473;4674.587551087708;4685.789139488723;4702.3416721659;4706.388169537964;4707.858764237069;3537.646235376461;3600.31593997141;3653.3241350350136;3673.926521469569;3706.759060661062;3694.131879008431;3712.2575484903127;3717.5167228260425;3718.293524230401;3732.981335093321;3675.6691897729197;3679.889603311905;3684.171061511165;3685.3550628640014;3693.3536631089587;3479.669431404038;3520.7359448041498;3604.6034936157002;3627.909302267438;3698.3158115748674;3274.8222432082634;3285.7349920280626;3294.6540613235506;3297.9835100824343;3303.289792694582;4566.611837993774;4572.7713614319155;4579.954200457986;4587.220172570671;4605.700629459075;4068.125353049079;4223.831046758126;4229.555896630871;4233.809478573472;4244.448221731155;4879.341288925985;4896.6817156885045;4903.681260718077;4918.975405122951;4928.359313289249;3561.145325121978;3578.159132603862;3584.9641503585153;3598.6221446747977;3603.1892824114625;5133;5141.431863281698;5157.8452646420665;5162.425460234627;5162.586993040548;3400.659934006629;3547.290541891632;3555.004598712365;3578.570571531433;3709.684676802448;3585.8744943926836;3591.1919818040733;3600.3519366513756;3629.419292913174;3633.4368172933237;4141.275276826544;4144.689148313889;4161.209370219709;4174.603412675791;4179.853705120367;4679.719216847;4917.631177661689;4937.703737775745;4954.727489988013;4967.975160124176;1206.3533277076726;1218.6648671615376;1225.2954551133134;1228.2875931959443;1229.4836168808943;812.8252425728497;829.8257365953096;841.5750046226616;842.0989541190867;842.6587232170981;4188.11534809337;4238.87283381499;4240.724352917051;4241.893952651209;4314.489928524991;5038.463268703007;5055.797768089235;5065.924011139836;5077.9278536485635;5104.566111880532;4329.372241025034;4358.694891357638;4361.672874534423;4362.258416069276;4367.825286988485;2520.621906713971;2582.9022665367143;2598.4932938077272;2600.6359109724654;2608.9869550652124;4579.542045795394;4586.72479651222;4607.838725644653;4615.353850460938;4620.330052142421;4955.950440495621;5007.198848184273;5020;5044.924326135111;5069.543741063322;4410.470743510735;4584.404027476407;4591.793369298322;4619.607333376701;4623.976880115578;4884.145274577006;4923.384576927884;4923.710474629314;4923.753812309298;4983.327250821238;4849.224124140121;4851.417829860439;4855.417349918032;4887.975560122177;4903.362562866804;4382.5179230285285;4596.494385617512;4619.538046195354;4624.1157427760845;4645.419322584677;3432.1248081738995;3437.7937323760652;3438.621751607371;3441.483777433305;3450.051235910145;4914.5822605078965;4934.235193545006;4944.75276236194;4947.579455746302;4950.4059512858685;4628.234701387419;4711.858644240679;4805.327254184487;4825.806967721252;4846.297286893451;4793.514010656708;4798.808047678054;4802.73584952831;4805.975970120127;4819;4729.3378926950945;4730.266808644666;4732.006278681515;4733.479317275028;4755.144074066701;4665.720056796603;4790.7365094920115;4796.448408432935;4796.618384039314;4797.832075877328;4861.562459378673;4887.315775791463;4897.3878265216845;4901.407042711205;4911.754412279301 08:25:10 INFO - PROCESS | 12591 | |5;yui.html;641.9743210271589;688.9827754306142;711.2141084102063;717.5192620943967;726.7855982485166;12475.251484910901;13246.536371227008;13345.53290634828;13446.32768361583;13460.596182114552;11979.221350612204;12022.81965770512;12047.09646776493;12056.975157111656;12071.637850864488;613.4049971527634;632.09610257332;733.8605664923674;737.7860420478055;761.4669731188163;768.1013214539003;769.5998080997878;769.6575024114271;770.6917233106747;771.167139489353;816.7508909782514;818.5661599352353;819.4264015189361;819.5287709567023;819.6065888373585;645.3481983196958;667.1627107979504;671.3487916720773;672.1631568696955;812.3460614205562;563.2283771233396;580.1037397221303;581.706238349635;581.7527550790896;582.2023827356549;12804;12842.422091005927;12851.35743212845;12861.356932153354;12866.292353920531;12999.87000129996;13022.348882555834;13025.674358141028;13249.602511924657;13300.467981280737;11854.3480108594;11917.165798394115;12037.277763334228;12264.448099835528;12417.93791031048;3973.642372186517;4014.979925100385;4028.7179897407195;4169.958300416987;4235.152969406131;62414;63578.68210658964;63731.36268637301;63928.360716393174;64796;10186.138613861385;10284.897151028543;10521.526531305957;10580.52387642558;10618.522166502526;19303.613927721366;19320.4203873884;19348.64559480823;19369.612607748048;19411.708824367644;6818.693158807866;6878.312168783082;6918.93081069193;6919.6540172991145;7101.644917754092;3625.3474374612824;3674.11821162919;3712.3874560697723;3750.249950010009;3865.8840234793;2884.8413337266234;2963.1406892001078;2971.7176868197485;2971.881124755029;2974.3159073412803;473.56905216253045;477.6942756635756;486.29730040091727;501.9749012549358;507.728365324557;445.65016462077114;529.5234289139805;563.2255648483335;571.6627189957861;582.4234008331806;7711.190325015905;7905.169957154531;7977.2022797719765;8006.919930800617;8148.307393871469;474.8124490826173;524.7350088205508;575.807104619957;591.9345178678448;644.3009334871716;3779.338615742234;3988.3618621020496;4007.458993035903;4008.07814202735;4039.1969407265633;49930.750346248766;61401.38598613957;65592.67203663952;65704;65921;44158.77920610441;48331.5166848327;52911.470885290655;55206.44793552093;55479.445205547425;50231.24653130206;50828;50871.49128508742;52274.21588676097;53865.22695460845;8123.309518690978;8234.382421318305;8348;8423.789405264917;8544.102869198894;36045.27909441849;36138.27723445569;36479;36813.44779828251;37849.62150378461;42785.786071069444;46182;47506.76246618745;47528.287075694585;49205.50794492009;9625.32622716403;9793.75515612087;9985.1512621428;10137.543810528692;10208.846867296848;10625.840612390666;10863.619773307897;10884.510197040994;11529;11558.133140014364;10147;10161.898381016392;10205.438700871524;10423.218258630784;10516.369017858953;10284.228682848667;10481.475926203508;11024;11109.444527773741;11263.324200547993;11725.941370293094;11869.821952670543;11876.16866819349;12209.755804883675;12744.235345879277;10064.84902726445;10351.63769268072;10408;10518.947405262925;10694.73263168427;10249.74375640615;10323.277370583986;10520.15838732915;10570.735731606772;10612.310199836986 08:25:10 INFO - PROCESS | 12591 | __end_tp_report 08:25:10 INFO - PROCESS | 12591 | __start_cc_report 08:25:10 INFO - PROCESS | 12591 | _x_x_mozilla_cycle_collect,2492 08:25:10 INFO - PROCESS | 12591 | __end_cc_report 08:25:10 INFO - PROCESS | 12591 | __startTimestamp1481214310717__endTimestamp 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | ------- Summary: start ------- 08:25:10 INFO - PROCESS | 12591 | Number of tests: 6 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#0] dojo.html Cycles:165 Average:4612.93 Median:4725.20 stddev:484.14 (10.2%) stddev-sans-first:458.10 08:25:10 INFO - PROCESS | 12591 | Values: 2561.5 2604.0 2604.7 2636.8 2646.7 4545.9 4583.0 4692.6 4703.7 4725.2 4640.8 4678.6 4705.7 4738.5 4787.2 4248.4 4268.6 4306.3 4335.8 4401.7 3971.9 4286.5 4323.3 4363.4 4400.3 4196.7 4374.6 4376.8 4440.5 4467.5 4233.7 4268.4 4287.7 4295.1 4301.5 4255.5 4285.9 4287.1 4290.3 4291.0 4660.9 4677.7 4680.5 4709.6 4738.3 5016.2 5017.9 5025.7 5032.3 5079.3 4846.6 4895.8 5038.9 5039.2 5089.9 4602.8 4610.6 4658.5 4658.5 4716.8 5068.7 5107.9 5110.7 5116.9 5169.3 4907.1 4920.9 4922.4 4925.1 4967.7 4872.8 4918.2 4919.6 4921.8 4925.8 4909.5 4913.7 4920.7 4927.7 4956.5 4887.1 4890.3 4890.8 4893.5 4939.3 4104.4 4140.9 4144.6 4182.1 4187.4 3660.0 3692.1 3696.9 3701.1 3751.0 4300.8 4301.1 4303.9 4337.1 4339.6 4932.2 5032.1 5034.0 5040.1 5042.6 4249.0 4254.5 4257.2 4267.7 4322.8 4508.3 4513.9 4514.3 4556.4 4559.6 4674.0 4680.0 4695.7 4696.3 4720.2 4861.0 4949.7 4949.9 5017.6 5022.6 4674.3 4675.3 4688.6 4689.6 4690.8 4938.9 4941.1 4941.4 4944.6 4945.1 5008.4 5014.5 5014.9 5021.1 5021.8 4845.9 4878.7 4888.6 4889.9 4890.8 4834.8 4854.3 4855.4 4855.8 4856.2 4796.9 4798.6 4801.1 4827.8 4830.0 4959.7 4973.1 4975.8 4976.7 5027.9 4688.3 4728.5 4838.3 4847.5 4894.2 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#1] ext.html Cycles:180 Average:44557.77 Median:35879.05 stddev:78266.42 (218.1%) stddev-sans-first:78416.25 08:25:10 INFO - PROCESS | 12591 | Values: 554.6 590.8 608.2 611.5 611.5 35970.5 37604.6 37713.4 41632.0 41643.2 38899.8 39280.6 39293.0 39353.6 39405.2 7202.1 7385.9 7400.3 7538.8 7545.0 9205.0 9513.9 9523.0 9788.0 9799.9 9701.9 9780.5 9781.3 9781.3 9781.5 9844.9 9861.7 9895.9 9906.9 9910.8 9714.2 9761.5 9773.2 9778.5 9781.6 37480.3 37714.8 37813.4 37857.6 37868.6 3045.9 3133.4 3271.4 3337.4 3647.5 27191.0 27270.5 27473.2 27491.9 27545.0 3434.4 3467.8 3614.4 3687.5 3691.2 248523.0 249601.0 250308.0 250965.0 251373.0 49760.0 49976.5 50058.2 50061.7 50086.2 53340.7 53379.2 53385.0 53455.5 53573.0 13602.5 13836.7 13968.9 13975.4 13981.2 9028.3 9253.2 9485.3 9885.6 10272.7 15027.8 15209.8 15275.1 15276.8 15378.3 5869.6 5937.6 5979.6 5981.8 6099.0 754.0 827.9 896.7 976.2 991.7 25874.5 27302.2 27552.0 27797.0 27895.3 900.8 936.8 936.9 970.1 1010.3 13616.7 14244.3 14482.4 14545.3 14803.9 350801.0 351306.0 351402.0 352592.0 353058.0 47748.8 47924.3 47945.5 47995.3 47996.0 1070.4 1092.3 1127.5 1135.1 1184.0 24908.0 27796.7 28121.6 28331.0 28426.8 35659.8 35837.8 35860.5 35897.6 35916.3 282946.0 283318.0 284225.3 284589.0 284837.0 23564.3 23979.9 25426.4 34014.0 34239.1 37027.6 37153.8 37291.4 37397.6 37424.8 32510.5 32891.3 33179.7 33316.2 33506.8 32405.2 32473.5 32589.5 32733.5 32976.7 32265.2 32673.7 32740.2 32970.3 33153.3 27467.5 29032.3 30057.8 30198.4 30543.2 23029.0 23209.9 23820.3 23831.4 24000.4 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#2] jquery.html Cycles:180 Average:21833.38 Median:3859.10 stddev:51830.21 (1343.1%) stddev-sans-first:51950.49 08:25:10 INFO - PROCESS | 12591 | Values: 345.3 358.7 369.6 370.3 389.6 12322.6 15263.3 15296.2 16016.8 16932.6 16122.3 16163.3 16351.3 16441.7 16682.4 4759.2 4764.9 4924.0 4940.2 4959.2 3656.7 3821.9 4855.9 4903.5 4948.7 3862.3 3871.0 3884.7 5562.8 5857.9 5621.2 5731.3 5893.5 5912.9 5915.4 5037.7 5041.8 5044.1 5045.5 5046.1 19601.5 19765.5 19797.1 19863.1 19937.2 1846.5 1934.8 2076.1 2212.3 2283.3 11985.0 12665.2 13054.9 13150.4 13404.5 1757.3 1789.4 1821.9 1903.2 1909.3 73233.0 76300.6 77624.4 79397.5 80460.2 8214.8 8264.0 8647.1 8686.2 9157.8 11879.7 11932.3 11960.8 11981.0 11982.2 6765.8 6886.0 6917.8 7129.5 7147.5 6398.9 6580.5 6679.3 7027.1 7086.3 3791.1 3798.6 3805.3 3811.3 3855.9 1850.6 1864.4 1898.7 1908.0 1910.3 716.4 797.9 870.3 884.7 918.1 15447.9 15968.7 16715.7 16780.4 17057.7 829.4 831.3 834.5 838.8 854.6 8720.3 9590.1 9591.3 9602.1 9749.8 251482.0 321329.0 322333.0 323161.0 323247.0 50371.7 60814.7 69019.0 76947.0 80682.0 880.3 886.9 896.3 911.1 913.2 15226.5 15316.5 15916.9 15985.1 16178.1 36203.3 36211.8 36402.3 37447.3 37924.6 48281.5 51337.0 51891.2 52002.0 53094.0 6968.2 7069.5 7112.6 7166.8 7232.4 10177.8 11746.9 11978.2 12074.0 12293.4 9944.4 10136.2 10216.3 10639.7 10805.5 9720.2 9975.3 9986.6 10117.9 10250.6 9933.2 10198.2 10573.6 10929.3 11000.4 7058.4 7118.4 7241.0 7273.0 7452.6 10225.9 10266.7 10345.8 10469.1 10536.4 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#3] mootools.html Cycles:180 Average:4771.07 Median:5912.07 stddev:2559.30 (43.3%) stddev-sans-first:2553.26 08:25:10 INFO - PROCESS | 12591 | Values: 1310.3 1324.2 1414.8 1643.7 1667.5 6360.6 6602.8 6892.7 7320.0 7342.6 6854.2 7174.6 7203.1 7208.1 7380.6 2056.9 2113.4 2116.1 2116.9 2118.3 1832.8 1890.8 2072.5 2094.4 2151.1 2059.2 2117.8 2120.5 2129.3 2132.3 2093.2 2096.5 2114.4 2125.4 2127.2 2172.6 2176.5 2193.5 2197.8 2199.5 7164.9 7331.2 7331.4 7333.1 7333.2 4341.5 4488.8 4494.5 4499.0 4499.7 2866.8 2912.8 2987.1 2992.3 2994.1 935.8 949.3 957.5 986.5 1002.1 9524.4 9777.0 9819.0 9819.3 9837.1 4176.6 4333.5 4346.4 4355.4 4371.1 7674.7 7723.7 7725.5 7734.6 7745.5 4558.0 4558.2 4559.5 4560.4 4565.3 4165.6 4172.2 4179.0 4213.0 4267.7 3159.1 3208.8 3250.4 3270.4 3295.9 953.5 954.3 977.5 977.8 986.2 689.7 743.8 812.9 836.2 858.6 4879.1 4892.8 5050.7 5150.2 5297.8 798.2 824.7 851.8 863.7 882.9 3514.4 3525.2 3562.4 3567.4 3719.5 8581.3 8919.5 8931.6 8934.8 8935.5 8876.6 8889.4 8892.6 8895.9 8897.6 6651.4 6796.1 6813.1 6819.6 6821.3 4727.8 4871.5 4901.1 4953.0 5091.3 7969.1 8012.1 8024.6 8048.8 8058.4 8074.2 8077.3 8137.3 8140.4 8168.0 5882.0 6009.6 6010.2 6012.8 6016.2 6526.3 6770.3 6792.5 6898.0 6977.3 5050.3 5912.8 5967.8 5971.1 6093.1 5911.3 5948.3 5995.2 6090.7 6117.5 5778.7 5790.3 5950.9 6014.3 6101.5 4302.7 4312.5 4435.7 4436.6 4544.1 4360.5 4422.3 4510.3 4553.8 4574.7 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#4] prototype.html Cycles:180 Average:4041.47 Median:4601.10 stddev:1165.98 (25.3%) stddev-sans-first:1134.77 08:25:10 INFO - PROCESS | 12591 | Values: 291.6 297.8 304.9 305.3 306.1 4725.3 4727.6 4728.4 4742.4 4748.7 4674.6 4685.8 4702.3 4706.4 4707.9 3537.6 3600.3 3653.3 3673.9 3706.8 3694.1 3712.3 3717.5 3718.3 3733.0 3675.7 3679.9 3684.2 3685.4 3693.4 3479.7 3520.7 3604.6 3627.9 3698.3 3274.8 3285.7 3294.7 3298.0 3303.3 4566.6 4572.8 4580.0 4587.2 4605.7 4068.1 4223.8 4229.6 4233.8 4244.4 4879.3 4896.7 4903.7 4919.0 4928.4 3561.1 3578.2 3585.0 3598.6 3603.2 5133.0 5141.4 5157.8 5162.4 5162.6 3400.7 3547.3 3555.0 3578.6 3709.7 3585.9 3591.2 3600.4 3629.4 3633.4 4141.3 4144.7 4161.2 4174.6 4179.9 4679.7 4917.6 4937.7 4954.7 4968.0 1206.4 1218.7 1225.3 1228.3 1229.5 812.8 829.8 841.6 842.1 842.7 4188.1 4238.9 4240.7 4241.9 4314.5 5038.5 5055.8 5065.9 5077.9 5104.6 4329.4 4358.7 4361.7 4362.3 4367.8 2520.6 2582.9 2598.5 2600.6 2609.0 4579.5 4586.7 4607.8 4615.4 4620.3 4956.0 5007.2 5020.0 5044.9 5069.5 4410.5 4584.4 4591.8 4619.6 4624.0 4884.1 4923.4 4923.7 4923.8 4983.3 4849.2 4851.4 4855.4 4888.0 4903.4 4382.5 4596.5 4619.5 4624.1 4645.4 3432.1 3437.8 3438.6 3441.5 3450.1 4914.6 4934.2 4944.8 4947.6 4950.4 4628.2 4711.9 4805.3 4825.8 4846.3 4793.5 4798.8 4802.7 4806.0 4819.0 4729.3 4730.3 4732.0 4733.5 4755.1 4665.7 4790.7 4796.4 4796.6 4797.8 4861.6 4887.3 4897.4 4901.4 4911.8 08:25:10 INFO - PROCESS | 12591 | 08:25:10 INFO - PROCESS | 12591 | [#5] yui.html Cycles:180 Average:14542.14 Median:4202.56 stddev:17889.80 (425.7%) stddev-sans-first:17909.54 08:25:10 INFO - PROCESS | 12591 | Values: 642.0 689.0 711.2 717.5 726.8 12475.3 13246.5 13345.5 13446.3 13460.6 11979.2 12022.8 12047.1 12057.0 12071.6 613.4 632.1 733.9 737.8 761.5 768.1 769.6 769.7 770.7 771.2 816.8 818.6 819.4 819.5 819.6 645.3 667.2 671.3 672.2 812.3 563.2 580.1 581.7 581.8 582.2 12804.0 12842.4 12851.4 12861.4 12866.3 12999.9 13022.3 13025.7 13249.6 13300.5 11854.3 11917.2 12037.3 12264.4 12417.9 3973.6 4015.0 4028.7 4170.0 4235.2 62414.0 63578.7 63731.4 63928.4 64796.0 10186.1 10284.9 10521.5 10580.5 10618.5 19303.6 19320.4 19348.6 19369.6 19411.7 6818.7 6878.3 6918.9 6919.7 7101.6 3625.3 3674.1 3712.4 3750.2 3865.9 2884.8 2963.1 2971.7 2971.9 2974.3 473.6 477.7 486.3 502.0 507.7 445.7 529.5 563.2 571.7 582.4 7711.2 7905.2 7977.2 8006.9 8148.3 474.8 524.7 575.8 591.9 644.3 3779.3 3988.4 4007.5 4008.1 4039.2 49930.8 61401.4 65592.7 65704.0 65921.0 44158.8 48331.5 52911.5 55206.4 55479.4 50231.2 50828.0 50871.5 52274.2 53865.2 8123.3 8234.4 8348.0 8423.8 8544.1 36045.3 36138.3 36479.0 36813.4 37849.6 42785.8 46182.0 47506.8 47528.3 49205.5 9625.3 9793.8 9985.2 10137.5 10208.8 10625.8 10863.6 10884.5 11529.0 11558.1 10147.0 10161.9 10205.4 10423.2 10516.4 10284.2 10481.5 11024.0 11109.4 11263.3 11725.9 11869.8 11876.2 12209.8 12744.2 10064.8 10351.6 10408.0 10518.9 10694.7 10249.7 10323.3 10520.2 10570.7 10612.3 08:25:10 INFO - PROCESS | 12591 | -------- Summary: end -------- 08:25:10 INFO - PROCESS | 12591 | 08:25:11 INFO - TEST-INFO | 12591: exit 0 08:25:11 INFO - TEST-OK | dromaeo_css | took 1123293ms 08:25:11 INFO - TEST-START | kraken 08:25:11 INFO - operating with platform_type : linux_ 08:25:11 INFO - Initialising browser for kraken test... 08:25:11 INFO - TEST-INFO | started process 12902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfXLk9/profile http://localhost:58246/getInfo.html) 08:25:16 INFO - PROCESS | 12902 | __metrics Screen width/height:1600/1200 08:25:16 INFO - PROCESS | 12902 | colorDepth:24 08:25:16 INFO - PROCESS | 12902 | Browser inner width/height: 1024/697 08:25:16 INFO - PROCESS | 12902 | __metrics 08:25:16 INFO - PROCESS | 12902 | 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" 08:25:16 INFO - PROCESS | 12902 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:17 INFO - PROCESS | 12902 | console.error: PushService: 08:25:17 INFO - PROCESS | 12902 | stateChangeProcessEnqueue: Error transitioning state 08:25:17 INFO - PROCESS | 12902 | UnknownError 08:25:18 INFO - TEST-INFO | 12902: exit 0 08:25:18 INFO - Browser initialized. 08:25:18 INFO - Running cycle 1/1 for kraken test... 08:25:18 INFO - TEST-INFO | started process 12983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfXLk9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:30 INFO - PROCESS | 12983 | RSS: Main: 173731840 08:25:30 INFO - PROCESS | 12983 | 08:25:33 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58246/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:34 INFO - PROCESS | 12983 | RSS: Main: 235556864 08:25:34 INFO - PROCESS | 12983 | 08:25:37 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58246/tests/kraken/driver.html?testName=audio-dft) 08:25:37 INFO - PROCESS | 12983 | RSS: Main: 217976832 08:25:37 INFO - PROCESS | 12983 | 08:25:40 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58246/tests/kraken/driver.html?testName=audio-fft) 08:25:41 INFO - PROCESS | 12983 | RSS: Main: 300838912 08:25:41 INFO - PROCESS | 12983 | 08:25:43 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58246/tests/kraken/driver.html?testName=audio-oscillator) 08:25:44 INFO - PROCESS | 12983 | RSS: Main: 210042880 08:25:44 INFO - PROCESS | 12983 | 08:25:46 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:46 INFO - PROCESS | 12983 | RSS: Main: 214761472 08:25:46 INFO - PROCESS | 12983 | 08:25:50 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58246/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:50 INFO - PROCESS | 12983 | RSS: Main: 253915136 08:25:50 INFO - PROCESS | 12983 | 08:25:54 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58246/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:54 INFO - PROCESS | 12983 | RSS: Main: 253726720 08:25:54 INFO - PROCESS | 12983 | 08:25:57 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58246/tests/kraken/driver.html?testName=json-parse-financial) 08:25:58 INFO - PROCESS | 12983 | RSS: Main: 252420096 08:25:58 INFO - PROCESS | 12983 | 08:25:59 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:00 INFO - PROCESS | 12983 | RSS: Main: 214282240 08:26:00 INFO - PROCESS | 12983 | 08:26:02 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:03 INFO - PROCESS | 12983 | RSS: Main: 222142464 08:26:03 INFO - PROCESS | 12983 | 08:26:05 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:05 INFO - PROCESS | 12983 | RSS: Main: 229859328 08:26:05 INFO - PROCESS | 12983 | 08:26:08 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:09 INFO - PROCESS | 12983 | RSS: Main: 239185920 08:26:09 INFO - PROCESS | 12983 | 08:26:12 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:13 INFO - PROCESS | 12983 | RSS: Main: 235528192 08:26:13 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:58246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58246/tests/kraken/driver.html?testName=ai-astar) 08:26:15 INFO - PROCESS | 12983 | RSS: Main: 286130176 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | __start_tp_report 08:26:15 INFO - PROCESS | 12983 | _x_x_mozilla_page_load 08:26:15 INFO - PROCESS | 12983 | _x_x_mozilla_page_load_details 08:26:15 INFO - PROCESS | 12983 | |i|pagename|runs| 08:26:15 INFO - PROCESS | 12983 | |0;ai-astar;108;115;116;117;115;116;115;114;114;116 08:26:15 INFO - PROCESS | 12983 | |1;audio-beat-detection;151;129;131;167;130;128;133;130;153;129 08:26:15 INFO - PROCESS | 12983 | |2;audio-dft;162;163;163;164;162;162;161;162;164;162 08:26:15 INFO - PROCESS | 12983 | |3;audio-fft;75;76;77;107;77;78;77;77;94;77 08:26:15 INFO - PROCESS | 12983 | |4;audio-oscillator;85;85;117;84;84;84;107;84;84;100 08:26:15 INFO - PROCESS | 12983 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;117;117;118 08:26:15 INFO - PROCESS | 12983 | |6;imaging-darkroom;147;147;146;148;146;146;146;147;145;147 08:26:15 INFO - PROCESS | 12983 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;96 08:26:15 INFO - PROCESS | 12983 | |8;json-parse-financial;64;64;65;63;66;65;66;65;64;74 08:26:15 INFO - PROCESS | 12983 | |9;json-stringify-tinderbox;67;66;66;66;67;66;67;66;66;66 08:26:15 INFO - PROCESS | 12983 | |10;stanford-crypto-aes;85;95;84;89;84;95;87;85;92;85 08:26:15 INFO - PROCESS | 12983 | |11;stanford-crypto-ccm;151;139;153;145;140;141;144;138;190;139 08:26:15 INFO - PROCESS | 12983 | |12;stanford-crypto-pbkdf2;182;179;187;180;183;185;185;182;186;185 08:26:15 INFO - PROCESS | 12983 | |13;stanford-crypto-sha256-iterative;70;71;69;70;70;75;70;73;74;68 08:26:15 INFO - PROCESS | 12983 | __end_tp_report 08:26:15 INFO - PROCESS | 12983 | __start_cc_report 08:26:15 INFO - PROCESS | 12983 | _x_x_mozilla_cycle_collect,1955 08:26:15 INFO - PROCESS | 12983 | __end_cc_report 08:26:15 INFO - PROCESS | 12983 | __startTimestamp1481214375332__endTimestamp 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | ------- Summary: start ------- 08:26:15 INFO - PROCESS | 12983 | Number of tests: 14 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.50 stddev:2.50 (2.2%) stddev-sans-first:1.00 08:26:15 INFO - PROCESS | 12983 | Values: 108.0 115.0 116.0 117.0 115.0 116.0 115.0 114.0 114.0 116.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:132.00 stddev:13.74 (10.4%) stddev-sans-first:13.76 08:26:15 INFO - PROCESS | 12983 | Values: 151.0 129.0 131.0 167.0 130.0 128.0 133.0 130.0 153.0 129.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:26:15 INFO - PROCESS | 12983 | Values: 162.0 163.0 163.0 164.0 162.0 162.0 161.0 162.0 164.0 162.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#3] audio-fft Cycles:10 Average:81.50 Median:77.00 stddev:10.50 (13.6%) stddev-sans-first:10.87 08:26:15 INFO - PROCESS | 12983 | Values: 75.0 76.0 77.0 107.0 77.0 78.0 77.0 77.0 94.0 77.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.00 stddev:12.15 (14.5%) stddev-sans-first:12.66 08:26:15 INFO - PROCESS | 12983 | Values: 85.0 85.0 117.0 84.0 84.0 84.0 107.0 84.0 84.0 100.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:26:15 INFO - PROCESS | 12983 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 08:26:15 INFO - PROCESS | 12983 | Values: 147.0 147.0 146.0 148.0 146.0 146.0 146.0 147.0 145.0 147.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:26:15 INFO - PROCESS | 12983 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.10 (4.8%) stddev-sans-first:3.23 08:26:15 INFO - PROCESS | 12983 | Values: 64.0 64.0 65.0 63.0 66.0 65.0 66.0 65.0 64.0 74.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:26:15 INFO - PROCESS | 12983 | Values: 67.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 66.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:4.41 (5.0%) stddev-sans-first:4.53 08:26:15 INFO - PROCESS | 12983 | Values: 85.0 95.0 84.0 89.0 84.0 95.0 87.0 85.0 92.0 85.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:144.50 stddev:15.63 (10.8%) stddev-sans-first:16.54 08:26:15 INFO - PROCESS | 12983 | Values: 151.0 139.0 153.0 145.0 140.0 141.0 144.0 138.0 190.0 139.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:185.00 stddev:2.63 (1.4%) stddev-sans-first:2.74 08:26:15 INFO - PROCESS | 12983 | Values: 182.0 179.0 187.0 180.0 183.0 185.0 185.0 182.0 186.0 185.0 08:26:15 INFO - PROCESS | 12983 | 08:26:15 INFO - PROCESS | 12983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:2.26 (3.2%) stddev-sans-first:2.37 08:26:15 INFO - PROCESS | 12983 | Values: 70.0 71.0 69.0 70.0 70.0 75.0 70.0 73.0 74.0 68.0 08:26:15 INFO - PROCESS | 12983 | -------- Summary: end -------- 08:26:15 INFO - PROCESS | 12983 | 08:26:16 INFO - TEST-INFO | 12983: exit 0 08:26:16 INFO - TEST-OK | kraken | took 64818ms 08:26:16 INFO - SUITE-END | took 1188s 08:26:16 INFO - Completed test suite (00:19:48) 08:26:16 INFO - javascript benchmark 08:26:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.462092960478, 2604.0365064925954, 2604.6874375074995, 2636.7890568754488, 2646.7220941801124, 4545.863624091283, 4583.0, 4692.624590032793, 4703.69425987311, 4725.196716558185, 4640.837570685027, 4678.602318802898, 4705.717656940586, 4738.47876733559, 4787.162246606838, 4248.362745588156, 4268.615824575788, 4306.332518459628, 4335.848245311415, 4401.66987475939, 3971.872561646284, 4286.507051689065, 4323.286657701476, 4363.367311739796, 4400.295952647577, 4196.685248606367, 4374.606285434326, 4376.846810361654, 4440.4893437254805, 4467.530909254514, 4233.724807887508, 4268.381084742695, 4287.742735435852, 4295.119500502421, 4301.548337424588, 4255.468066491689, 4285.914281714348, 4287.078278170208, 4290.313549832012, 4291.034517233597, 4660.930086048712, 4677.672562920597, 4680.531946805327, 4709.6467764917425, 4738.336632871401, 5016.247562865563, 5017.949820501784, 5025.673331233458, 5032.345795046657, 5079.288899554065, 4846.61227101831, 4895.804167833282, 5038.874028149289, 5039.168537191359, 5089.949100508985, 4602.815887364468, 4610.585047345755, 4658.464276608233, 4658.464276608233, 4716.8113275468595, 5068.670536415121, 5107.897842043139, 5110.693358398508, 5116.897662046813, 5169.25045868347, 4907.067657145131, 4920.852374428773, 4922.409310882717, 4925.064237794808, 4967.7019378837385, 4872.829450969199, 4918.2376731606655, 4919.606431485473, 4921.753912304371, 4925.802967881316, 4909.459959404463, 4913.656044076952, 4920.729359885169, 4927.679700819507, 4956.504349565087, 4887.144749668793, 4890.266460030953, 4890.828820991248, 4893.486183950705, 4939.333190019373, 4104.445899803548, 4140.896477588084, 4144.606262405066, 4182.1008483176265, 4187.434696315959, 3660.048387419237, 3692.095436618046, 3696.8890933272046, 3701.130234394915, 3750.9624903750614, 4300.78496075195, 4301.096769678403, 4303.892402689958, 4337.067530480962, 4339.5660433956355, 4932.21084626458, 5032.094223039888, 5034.0, 5040.067587496252, 5042.647014708935, 4248.9787551062045, 4254.468191476066, 4257.169851878916, 4267.679924005712, 4322.762248076323, 4508.256137737302, 4513.887152821206, 4514.345419914094, 4556.384888040072, 4559.566841150086, 4674.0, 4679.953200467951, 4695.694779839299, 4696.272077827942, 4720.244760838249, 4860.95139048605, 4949.653524253267, 4949.851504454872, 5017.64876458659, 5022.598192144693, 4674.345591617244, 4675.298705194248, 4688.5545873142, 4689.648276379217, 4690.835820746258, 4938.901221975612, 4941.135301322182, 4941.357623508921, 4944.579710724629, 4945.134601444661, 5008.449070602303, 5014.498550144956, 5014.924776128288, 5021.1213037717525, 5021.7740201690285, 4845.878853028703, 4878.731669758197, 4888.560029597354, 4889.853304400874, 4890.804367825247, 4834.830780922651, 4854.320395144753, 4855.441624213261, 4855.830045948375, 4856.174450343521, 4796.880077998078, 4798.568128868279, 4801.063792560417, 4827.831025914076, 4829.95170048295, 4959.70241785494, 4973.104841128632, 4975.825846095369, 4976.701397916137, 5027.874303142451, 4688.296755486705, 4728.456227533878, 4838.274258861199, 4847.491013443538, 4894.167991441393], "value": 4582.01832226545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.595145543753, 590.8138936235085, 608.1637748096367, 611.4863514647695, 611.4924612571568, 35970.460443093376, 37604.623953760456, 37713.43429848555, 41632.0, 41643.16713665725, 38899.805500972456, 39280.60719392805, 39293.0, 39353.60646393535, 39405.21189576207, 7202.135743710762, 7385.889211661829, 7400.333969942718, 7538.773836784878, 7544.962275188616, 9205.0, 9513.857292140623, 9522.952385238064, 9787.951060244688, 9799.90200097997, 9701.902980970206, 9780.46207458593, 9781.315307928448, 9781.315307928448, 9781.510924453785, 9844.901550984507, 9861.704148875546, 9895.901040989569, 9906.851397228975, 9910.752231194207, 9714.22286217101, 9761.463119528424, 9773.21814254858, 9778.462184579845, 9781.608735650565, 37480.25039499222, 37714.811425942695, 37813.432798508045, 37857.621423785684, 37868.62131378678, 3045.9086227413213, 3133.4359815233247, 3271.4275001874576, 3337.4159522083537, 3647.544056992876, 27191.0, 27270.45459090827, 27473.17580472589, 27491.86254068737, 27545.0, 3434.3818112739696, 3467.8092704901474, 3614.4036234021355, 3687.539057617798, 3691.187938653492, 248523.0, 249601.0, 250308.0, 250965.0, 251373.0, 49760.0, 49976.500234997184, 50058.24912626314, 50061.74969125204, 50086.248706269434, 53340.73329633327, 53379.19931201035, 53385.0, 53455.46544534583, 53573.0, 13602.455901764017, 13836.723265534632, 13968.930155349159, 13975.440982360795, 13981.161130332213, 9028.277737780962, 9253.167214950687, 9485.288603354638, 9885.604575817031, 10272.743181420525, 15027.774583381259, 15209.847901520843, 15275.083494990336, 15276.847231527543, 15378.3079761411, 5869.618474799125, 5937.584369094208, 5979.581429299994, 5981.790637327673, 6099.0, 753.9660715267717, 827.9337652987747, 896.6816780043122, 976.2141476111798, 991.6677912899115, 25874.482510349688, 27302.180934571996, 27552.0, 27797.0, 27895.302617434725, 900.7928176519306, 936.765808547863, 936.8828896387952, 970.0735797313548, 1010.2625083688948, 13616.65958351049, 14244.287785610679, 14482.420703171754, 14545.34545945435, 14803.851961480463, 350801.0, 351306.0, 351402.0, 352592.0, 353058.0, 47748.761256193495, 47924.28113578299, 47945.5205447948, 47995.280070798966, 47996.0, 1070.4219721350385, 1092.2790957967861, 1127.537709539085, 1135.1486385211092, 1184.040926849255, 24908.0, 27796.722032779413, 28121.578176326962, 28331.0, 28426.773512114396, 35659.82170089133, 35837.82081089578, 35860.462093068105, 35897.64102359048, 35916.28167436689, 282946.0, 283318.0, 284225.26057939365, 284589.0, 284837.0, 23564.293071207892, 23979.880100599385, 25426.364340891625, 34014.0, 34239.14402139966, 37027.62972370242, 37153.81423092867, 37291.44062839005, 37397.626023739416, 37424.812875935444, 32510.512342315356, 32891.34217315688, 33179.668203317655, 33316.1670958228, 33506.83246583751, 32405.18987025343, 32473.51289730703, 32589.511157332185, 32733.50899736458, 32976.67023329736, 32265.193370165933, 32673.673263267065, 32740.181495462803, 32970.340593187524, 33153.33693326168, 27467.450650987266, 29032.274193145342, 30057.849710751307, 30198.396032079676, 30543.2364190897, 23029.0, 23209.88395058014, 23820.285391438283, 23831.404214894766, 24000.399989999692], "value": 17151.176150094227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2921510902649, 358.7363287983333, 369.59529315399635, 370.3167655675279, 389.6240128276213, 12322.568710095149, 15263.313150908209, 15296.158711270875, 16016.839831601681, 16932.576685582866, 16122.274497647604, 16163.272652730626, 16351.345946162139, 16441.67116657666, 16682.41611543596, 4759.214729569617, 4764.928526072112, 4923.950760492403, 4940.1601727706375, 4959.181735013718, 3656.7074634029345, 3821.866234681787, 4855.902881942359, 4903.485134060926, 4948.653594248404, 3862.304785138674, 3871.032241939515, 3884.747491413063, 5562.7774889004395, 5857.8828423431505, 5621.156826476021, 5731.283589551306, 5893.469587737103, 5912.911306330366, 5915.438033386843, 5037.672551284155, 5041.8487445376695, 5044.117279476113, 5045.520675535819, 5046.0664777016, 19601.509962250915, 19765.505862353555, 19797.109130089037, 19863.106160222826, 19937.202511899508, 1846.5291350705618, 1934.8258656720964, 2076.0559890994673, 2212.3362991102604, 2283.315005498344, 11985.0, 12665.176763510342, 13054.934725326313, 13150.408231629504, 13404.530841420601, 1757.314647287559, 1789.4363275568155, 1821.9180136893872, 1903.1626084522766, 1909.255390397746, 73233.0, 76300.61849690771, 77624.40192583637, 79397.53254284048, 80460.19539804645, 8214.8357032859, 8264.0, 8647.135286471428, 8686.174813392718, 9157.771055723528, 11879.703007424883, 11932.343721095423, 11960.820587691192, 11981.0, 11982.161248712506, 6765.797026089225, 6885.965570172117, 6917.827054323682, 7129.500934934505, 7147.463940204506, 6398.936010639927, 6580.506462015368, 6679.332066793282, 7027.086478757728, 7086.326798954091, 3791.109089363997, 3798.582155962842, 3805.257974694963, 3811.3411125320004, 3855.9036024099623, 1850.5651171974575, 1864.4499872537633, 1898.734177215191, 1907.9663335296943, 1910.3313840156113, 716.3874886971564, 797.9002624671916, 870.3472395703222, 884.7036242858586, 918.1094338491653, 15447.922760386351, 15968.680626387408, 16715.6656866862, 16780.412685555948, 17057.737412046557, 829.4323728153794, 831.264331066998, 834.4576025583419, 838.8070743728977, 854.6410507586828, 8720.30237580992, 9590.08894155054, 9591.273570757192, 9602.135807777333, 9749.805003899883, 251482.0, 321329.0, 322333.0, 323161.0, 323247.0, 50371.74814125979, 60814.695926520086, 69019.0, 76947.0, 80682.0, 880.2561835249204, 886.9423487473293, 896.3008853094597, 911.098012967171, 913.196387179278, 15226.543203703906, 15316.540503784905, 15916.920415397848, 15985.120818355103, 16178.110203938897, 36203.27593448063, 36211.81894090513, 36402.27195456129, 37447.2510549782, 37924.62075379211, 48281.5171848277, 51337.0, 51891.22163167631, 52002.0, 53094.0, 6968.198657154289, 7069.540479868998, 7112.57324560528, 7166.814121692725, 7232.385247253832, 10177.796444071226, 11746.941265293619, 11978.161528692908, 12074.0, 12293.385330733248, 9944.403335799585, 10136.189104871444, 10216.284860060021, 10639.680809575726, 10805.45972701346, 9720.222382209266, 9975.251856110675, 9986.60053597848, 10117.949410252902, 10250.58997640086, 9933.205343572641, 10198.18414526851, 10573.577056917944, 10929.344239345664, 11000.394978275952, 7058.435325174077, 7118.359347658736, 7241.0, 7272.96363518179, 7452.590107544137, 10225.948870255601, 10266.691999240034, 10345.84481232767, 10469.057784799405, 10536.420496872746], "value": 7970.8336572169865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.2858941876677, 1324.1988596898875, 1414.7524183267926, 1643.7205675035257, 1667.4997500749764, 6360.586561873475, 6602.834929126774, 6892.724291028353, 7320.048393708824, 7342.568199201158, 6854.21176564694, 7174.6412679366085, 7203.06360173178, 7208.135023797152, 7380.55716657001, 2056.91772329107, 2113.4399384163207, 2116.100657220683, 2116.904739286736, 2118.3433135727896, 1832.7709036370454, 1890.8298253157213, 2072.5077943880383, 2094.4030951178916, 2151.0535364439675, 2059.227789578908, 2117.8093971542557, 2120.5122821751006, 2129.3292612826986, 2132.253711201075, 2093.16273490605, 2096.486360841596, 2114.38682781993, 2125.3517677108475, 2127.244828086038, 2172.587208430409, 2176.5102851858364, 2193.5393567350875, 2197.835162362829, 2199.48312146647, 7164.892526612053, 7331.193568707438, 7331.413486921034, 7333.083364579427, 7333.230010848891, 4341.5441378655105, 4488.798004089824, 4494.483134439549, 4498.977505112453, 4499.730016199039, 2866.784991125674, 2912.7524160446387, 2987.0889378739475, 2992.341684829334, 2994.086803524924, 935.7988032573029, 949.2595775295281, 957.5451660461295, 986.531397586148, 1002.0630710285833, 9524.380915240487, 9777.0, 9818.9509052455, 9819.312648114706, 9837.065478779505, 4176.582341765799, 4333.501647310537, 4346.413234213341, 4355.4337936068105, 4371.0820727646915, 7674.693012279558, 7723.729669461542, 7725.497842640323, 7734.613269336511, 7745.457817952802, 4558.0, 4558.247889098262, 4559.52125026874, 4560.3843481129625, 4565.292379681155, 4165.58344165581, 4172.165566886635, 4179.038821071171, 4212.978935105366, 4267.722598031118, 3159.1154476746547, 3208.8235147066666, 3250.447423937936, 3270.427675156838, 3295.884644037495, 953.4851180362665, 954.289054654287, 977.53567055648, 977.7995510920244, 986.2356673578034, 689.7344522358928, 743.7880204141794, 812.9105798362175, 836.193073683898, 858.6222062292571, 4879.072766257308, 4892.755362231946, 5050.696958182521, 5150.244619128748, 5297.788088476418, 798.2120051085527, 824.6824972385555, 851.7700220940311, 863.7106569299355, 882.8543290357147, 3514.3674138655288, 3525.206828463575, 3562.4478205877613, 3567.4292113261754, 3719.497867787868, 8581.313494920392, 8919.509426981578, 8931.553422328987, 8934.776630584287, 8935.508547029845, 8876.556172191495, 8889.422187557788, 8892.59983300753, 8895.911040889638, 8897.644094236159, 6651.368120028589, 6796.116504854337, 6813.148356455443, 6819.624920629413, 6821.283765204681, 4727.834525791718, 4871.537203965618, 4901.14230009754, 4953.028183090261, 5091.287219789158, 7969.083555391204, 8012.118666946748, 8024.598770061591, 8048.839023219386, 8058.3956203283815, 8074.192580741878, 8077.27304542594, 8137.349012078901, 8140.430169888051, 8168.0, 5882.0, 6009.609375390761, 6010.248718910137, 6012.819615411545, 6016.217891674054, 6526.347365263626, 6770.289119642367, 6792.524523283323, 6897.965510172417, 6977.267386924503, 5050.3182070420025, 5912.822615321547, 5967.791127310524, 5971.134185543159, 6093.086037094294, 5911.3201981772645, 5948.286205655176, 5995.16067750524, 6090.665013424305, 6117.480014198843, 5778.682172480386, 5790.305163380422, 5950.910736338872, 6014.308354539109, 6101.5118790497545, 4302.655787536927, 4312.460942382202, 4435.733855968652, 4436.600705936481, 4544.068465964536, 4360.454943132108, 4422.314541246112, 4510.345999830072, 4553.791411165648, 4574.6569007323915], "value": 3898.163680911518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.55974478537416, 297.7692288476431, 304.9252933031409, 305.25213227592377, 306.0619202145424, 4725.29120631905, 4727.645426593002, 4728.432588089429, 4742.383490146281, 4748.667593268473, 4674.587551087708, 4685.789139488723, 4702.3416721659, 4706.388169537964, 4707.858764237069, 3537.646235376461, 3600.31593997141, 3653.3241350350136, 3673.926521469569, 3706.759060661062, 3694.131879008431, 3712.2575484903127, 3717.5167228260425, 3718.293524230401, 3732.981335093321, 3675.6691897729197, 3679.889603311905, 3684.171061511165, 3685.3550628640014, 3693.3536631089587, 3479.669431404038, 3520.7359448041498, 3604.6034936157002, 3627.909302267438, 3698.3158115748674, 3274.8222432082634, 3285.7349920280626, 3294.6540613235506, 3297.9835100824343, 3303.289792694582, 4566.611837993774, 4572.7713614319155, 4579.954200457986, 4587.220172570671, 4605.700629459075, 4068.125353049079, 4223.831046758126, 4229.555896630871, 4233.809478573472, 4244.448221731155, 4879.341288925985, 4896.6817156885045, 4903.681260718077, 4918.975405122951, 4928.359313289249, 3561.145325121978, 3578.159132603862, 3584.9641503585153, 3598.6221446747977, 3603.1892824114625, 5133.0, 5141.431863281698, 5157.8452646420665, 5162.425460234627, 5162.586993040548, 3400.659934006629, 3547.290541891632, 3555.004598712365, 3578.570571531433, 3709.684676802448, 3585.8744943926836, 3591.1919818040733, 3600.3519366513756, 3629.419292913174, 3633.4368172933237, 4141.275276826544, 4144.689148313889, 4161.209370219709, 4174.603412675791, 4179.853705120367, 4679.719216847, 4917.631177661689, 4937.703737775745, 4954.727489988013, 4967.975160124176, 1206.3533277076726, 1218.6648671615376, 1225.2954551133134, 1228.2875931959443, 1229.4836168808943, 812.8252425728497, 829.8257365953096, 841.5750046226616, 842.0989541190867, 842.6587232170981, 4188.11534809337, 4238.87283381499, 4240.724352917051, 4241.893952651209, 4314.489928524991, 5038.463268703007, 5055.797768089235, 5065.924011139836, 5077.9278536485635, 5104.566111880532, 4329.372241025034, 4358.694891357638, 4361.672874534423, 4362.258416069276, 4367.825286988485, 2520.621906713971, 2582.9022665367143, 2598.4932938077272, 2600.6359109724654, 2608.9869550652124, 4579.542045795394, 4586.72479651222, 4607.838725644653, 4615.353850460938, 4620.330052142421, 4955.950440495621, 5007.198848184273, 5020.0, 5044.924326135111, 5069.543741063322, 4410.470743510735, 4584.404027476407, 4591.793369298322, 4619.607333376701, 4623.976880115578, 4884.145274577006, 4923.384576927884, 4923.710474629314, 4923.753812309298, 4983.327250821238, 4849.224124140121, 4851.417829860439, 4855.417349918032, 4887.975560122177, 4903.362562866804, 4382.5179230285285, 4596.494385617512, 4619.538046195354, 4624.1157427760845, 4645.419322584677, 3432.1248081738995, 3437.7937323760652, 3438.621751607371, 3441.483777433305, 3450.051235910145, 4914.5822605078965, 4934.235193545006, 4944.75276236194, 4947.579455746302, 4950.4059512858685, 4628.234701387419, 4711.858644240679, 4805.327254184487, 4825.806967721252, 4846.297286893451, 4793.514010656708, 4798.808047678054, 4802.73584952831, 4805.975970120127, 4819.0, 4729.3378926950945, 4730.266808644666, 4732.006278681515, 4733.479317275028, 4755.144074066701, 4665.720056796603, 4790.7365094920115, 4796.448408432935, 4796.618384039314, 4797.832075877328, 4861.562459378673, 4887.315775791463, 4897.3878265216845, 4901.407042711205, 4911.754412279301], "value": 3673.469106110249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9743210271589, 688.9827754306142, 711.2141084102063, 717.5192620943967, 726.7855982485166, 12475.251484910901, 13246.536371227008, 13345.53290634828, 13446.32768361583, 13460.596182114552, 11979.221350612204, 12022.81965770512, 12047.09646776493, 12056.975157111656, 12071.637850864488, 613.4049971527634, 632.09610257332, 733.8605664923674, 737.7860420478055, 761.4669731188163, 768.1013214539003, 769.5998080997878, 769.6575024114271, 770.6917233106747, 771.167139489353, 816.7508909782514, 818.5661599352353, 819.4264015189361, 819.5287709567023, 819.6065888373585, 645.3481983196958, 667.1627107979504, 671.3487916720773, 672.1631568696955, 812.3460614205562, 563.2283771233396, 580.1037397221303, 581.706238349635, 581.7527550790896, 582.2023827356549, 12804.0, 12842.422091005927, 12851.35743212845, 12861.356932153354, 12866.292353920531, 12999.87000129996, 13022.348882555834, 13025.674358141028, 13249.602511924657, 13300.467981280737, 11854.3480108594, 11917.165798394115, 12037.277763334228, 12264.448099835528, 12417.93791031048, 3973.642372186517, 4014.979925100385, 4028.7179897407195, 4169.958300416987, 4235.152969406131, 62414.0, 63578.68210658964, 63731.36268637301, 63928.360716393174, 64796.0, 10186.138613861385, 10284.897151028543, 10521.526531305957, 10580.52387642558, 10618.522166502526, 19303.613927721366, 19320.4203873884, 19348.64559480823, 19369.612607748048, 19411.708824367644, 6818.693158807866, 6878.312168783082, 6918.93081069193, 6919.6540172991145, 7101.644917754092, 3625.3474374612824, 3674.11821162919, 3712.3874560697723, 3750.249950010009, 3865.8840234793, 2884.8413337266234, 2963.1406892001078, 2971.7176868197485, 2971.881124755029, 2974.3159073412803, 473.56905216253045, 477.6942756635756, 486.29730040091727, 501.9749012549358, 507.728365324557, 445.65016462077114, 529.5234289139805, 563.2255648483335, 571.6627189957861, 582.4234008331806, 7711.190325015905, 7905.169957154531, 7977.2022797719765, 8006.919930800617, 8148.307393871469, 474.8124490826173, 524.7350088205508, 575.807104619957, 591.9345178678448, 644.3009334871716, 3779.338615742234, 3988.3618621020496, 4007.458993035903, 4008.07814202735, 4039.1969407265633, 49930.750346248766, 61401.38598613957, 65592.67203663952, 65704.0, 65921.0, 44158.77920610441, 48331.5166848327, 52911.470885290655, 55206.44793552093, 55479.445205547425, 50231.24653130206, 50828.0, 50871.49128508742, 52274.21588676097, 53865.22695460845, 8123.309518690978, 8234.382421318305, 8348.0, 8423.789405264917, 8544.102869198894, 36045.27909441849, 36138.27723445569, 36479.0, 36813.44779828251, 37849.62150378461, 42785.786071069444, 46182.0, 47506.76246618745, 47528.287075694585, 49205.50794492009, 9625.32622716403, 9793.75515612087, 9985.1512621428, 10137.543810528692, 10208.846867296848, 10625.840612390666, 10863.619773307897, 10884.510197040994, 11529.0, 11558.133140014364, 10147.0, 10161.898381016392, 10205.438700871524, 10423.218258630784, 10516.369017858953, 10284.228682848667, 10481.475926203508, 11024.0, 11109.444527773741, 11263.324200547993, 11725.941370293094, 11869.821952670543, 11876.16866819349, 12209.755804883675, 12744.235345879277, 10064.84902726445, 10351.63769268072, 10408.0, 10518.947405262925, 10694.73263168427, 10249.74375640615, 10323.277370583986, 10520.15838732915, 10570.735731606772, 10612.310199836986], "value": 6170.252441943588, "unit": "score"}], "name": "dromaeo_css", "value": 6173.399671280165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 116.0, 117.0, 115.0, 116.0, 115.0, 114.0, 114.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 131.0, 167.0, 130.0, 128.0, 133.0, 130.0, 153.0, 129.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 162.0, 162.0, 161.0, 162.0, 164.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 107.0, 77.0, 78.0, 77.0, 77.0, 94.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 84.0, 84.0, 84.0, 107.0, 84.0, 84.0, 100.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 145.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 66.0, 65.0, 66.0, 65.0, 64.0, 74.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 84.0, 89.0, 84.0, 95.0, 87.0, 85.0, 92.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 139.0, 153.0, 145.0, 140.0, 141.0, 144.0, 138.0, 190.0, 139.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 187.0, 180.0, 183.0, 185.0, 185.0, 182.0, 186.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 70.0, 70.0, 75.0, 70.0, 73.0, 74.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1569.4, "alertThreshold": 2.0}]} 08:26:17 INFO - Return code: 0 08:26:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:17 INFO - # TBPL SUCCESS # 08:26:17 INFO - Running post-action listener: _resource_record_post_action 08:26:17 INFO - [mozharness: 2016-12-08 16:26:17.114641Z] Finished run-tests step (success) 08:26:17 INFO - Running post-run listener: _resource_record_post_run 08:26:17 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390483968; Read time: 12; Write time: 264348 08:26:17 INFO - TinderboxPrint: CPU usage
13.1% 08:26:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:26:17 INFO - TinderboxPrint: I/O write bytes / time
390,483,968 / 264,348 08:26:17 INFO - TinderboxPrint: CPU idle
8,355.1 (86.9%) 08:26:17 INFO - TinderboxPrint: CPU user
1,210.7 (12.6%) 08:26:17 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99868672; Read time: 0; Write time: 93312 08:26:17 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290615296; Read time: 0; Write time: 171036 08:26:17 INFO - Running post-run listener: _upload_blobber_files 08:26:17 INFO - Blob upload gear active. 08:26:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:17 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 08:26:17 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:26:17 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:26:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:19 INFO - (blobuploader) - INFO - Done attempting. 08:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:19 INFO - (blobuploader) - INFO - Done attempting. 08:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:23 INFO - (blobuploader) - INFO - Done attempting. 08:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:23 INFO - Return code: 0 08:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cba3b9bd03b8ce451a644a4dbfe9d960ec1673332430bdc6f8ce6c0113f23f3c2c85c61ae94af4152ed96c212a66602d3cfff8c0af9f54b8209917b1d1d9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/311670edb76f600398685a00e95b71ca03e9954cdc6665210754ed693f6cdc66f3ab63ac80f83c0b83b1eb30672ccec0cb0ebcd74cd3b09f2f23ed0eea396c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/637c12e5a713029744984bdf439b3446a3b3980d197d778af56017bef49662fb508154fd2d731e452e2ed9d8821ed9fcd092d86f42c6c45e780829a7b9f92d33"} 08:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:23 INFO - Contents: 08:26:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cba3b9bd03b8ce451a644a4dbfe9d960ec1673332430bdc6f8ce6c0113f23f3c2c85c61ae94af4152ed96c212a66602d3cfff8c0af9f54b8209917b1d1d9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/311670edb76f600398685a00e95b71ca03e9954cdc6665210754ed693f6cdc66f3ab63ac80f83c0b83b1eb30672ccec0cb0ebcd74cd3b09f2f23ed0eea396c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/637c12e5a713029744984bdf439b3446a3b3980d197d778af56017bef49662fb508154fd2d731e452e2ed9d8821ed9fcd092d86f42c6c45e780829a7b9f92d33"} 08:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:23 INFO - Copying logs to upload dir... 08:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.133058 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-08 08:26:22.641249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 08:26:22.645220) ========= 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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 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-Non-PGO/sha512/8cba3b9bd03b8ce451a644a4dbfe9d960ec1673332430bdc6f8ce6c0113f23f3c2c85c61ae94af4152ed96c212a66602d3cfff8c0af9f54b8209917b1d1d9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/311670edb76f600398685a00e95b71ca03e9954cdc6665210754ed693f6cdc66f3ab63ac80f83c0b83b1eb30672ccec0cb0ebcd74cd3b09f2f23ed0eea396c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/637c12e5a713029744984bdf439b3446a3b3980d197d778af56017bef49662fb508154fd2d731e452e2ed9d8821ed9fcd092d86f42c6c45e780829a7b9f92d33"} build_url:https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011872 build_url: 'https://queue.taskcluster.net/v1/task/BnrY_gVoS1a0PGHWQugt2Q/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-Non-PGO/sha512/8cba3b9bd03b8ce451a644a4dbfe9d960ec1673332430bdc6f8ce6c0113f23f3c2c85c61ae94af4152ed96c212a66602d3cfff8c0af9f54b8209917b1d1d9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/311670edb76f600398685a00e95b71ca03e9954cdc6665210754ed693f6cdc66f3ab63ac80f83c0b83b1eb30672ccec0cb0ebcd74cd3b09f2f23ed0eea396c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/637c12e5a713029744984bdf439b3446a3b3980d197d778af56017bef49662fb508154fd2d731e452e2ed9d8821ed9fcd092d86f42c6c45e780829a7b9f92d33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 08:26:22.670653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:26:22.670999) ========= 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=db7e7c15f3ca076d53731445000001ba-1481213133.167661-1371975095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:26:22.756770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 08:26:22.757121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 08:26:22.757410) ========= ========= Total master_lag: 0.16 =========