builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1476268379.88 results: success (0) buildid: 20161012005247 builduid: d739623750ad4ba4b489649eee05a4dd revision: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:59.878377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:59.879008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:59.879325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:59.893734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:59.893998) ========= 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=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 03:33:00-- 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% 46.4M=0s 2016-10-12 03:33:00 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.021428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.021789) ========= 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=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.072668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.072986) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 --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=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 03:33:00,543 truncating revision to first 12 chars 2016-10-12 03:33:00,543 Setting DEBUG logging. 2016-10-12 03:33:00,543 attempt 1/10 2016-10-12 03:33:00,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2da62d29c6a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 03:33:00,864 unpacking tar archive at: mozilla-aurora-2da62d29c6a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.735018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.735302) ========= script_repo_revision: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.735668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.735928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:33:00.743431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-12 03:33:00.743692) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:01 INFO - MultiFileLogger online at 20161012 03:33:01 in /builds/slave/test 03:33:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:01 INFO - {'append_to_log': False, 03:33:01 INFO - 'base_work_dir': '/builds/slave/test', 03:33:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:01 INFO - 'branch': 'Mozilla-Aurora', 03:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:01 INFO - 'config_files': ('talos/linux_config.py',), 03:33:01 INFO - 'default_actions': ('clobber', 03:33:01 INFO - 'read-buildbot-config', 03:33:01 INFO - 'download-and-extract', 03:33:01 INFO - 'populate-webroot', 03:33:01 INFO - 'create-virtualenv', 03:33:01 INFO - 'install', 03:33:01 INFO - 'run-tests'), 03:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:01 INFO - 'download_minidump_stackwalk': True, 03:33:01 INFO - 'download_symbols': 'ondemand', 03:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:01 INFO - 'installer_path': 'installer.exe', 03:33:01 INFO - 'log_level': 'info', 03:33:01 INFO - 'log_name': 'talos', 03:33:01 INFO - 'log_to_console': True, 03:33:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:01 INFO - 'opt_config_files': (), 03:33:01 INFO - 'pip_index': False, 03:33:01 INFO - 'sps_profile': False, 03:33:01 INFO - 'sps_profile_interval': 0, 03:33:01 INFO - 'suite': 'dromaeojs', 03:33:01 INFO - 'system_bits': '32', 03:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:01 INFO - 'title': 'talos-linux64-ix-065', 03:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:01 INFO - 'use_talos_json': True, 03:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:01 INFO - 'work_dir': 'build'} 03:33:01 INFO - [mozharness: 2016-10-12 10:33:01.312301Z] Running clobber step. 03:33:01 INFO - Running pre-action listener: _resource_record_pre_action 03:33:01 INFO - Running main action method: clobber 03:33:01 INFO - rmtree: /builds/slave/test/build 03:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:02 INFO - Running post-action listener: _resource_record_post_action 03:33:02 INFO - [mozharness: 2016-10-12 10:33:02.280313Z] Finished clobber step (success) 03:33:02 INFO - [mozharness: 2016-10-12 10:33:02.280411Z] Running read-buildbot-config step. 03:33:02 INFO - Running pre-action listener: _resource_record_pre_action 03:33:02 INFO - Running main action method: read_buildbot_config 03:33:02 INFO - Using buildbot properties: 03:33:02 INFO - { 03:33:02 INFO - "project": "", 03:33:02 INFO - "product": "firefox", 03:33:02 INFO - "script_repo_revision": "production", 03:33:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:33:02 INFO - "repository": "", 03:33:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:33:02 INFO - "buildid": "20161012005247", 03:33:02 INFO - "pgo_build": "True", 03:33:02 INFO - "basedir": "/builds/slave/test", 03:33:02 INFO - "buildnumber": 514, 03:33:02 INFO - "slavename": "talos-linux64-ix-065", 03:33:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:33:02 INFO - "platform": "ubuntu64_hw", 03:33:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:33:02 INFO - "branch": "mozilla-aurora", 03:33:02 INFO - "repo_path": "releases/mozilla-aurora", 03:33:02 INFO - "revision": "2da62d29c6a4826c874bc7f6b9e315b0293b2fc9", 03:33:02 INFO - "stage_platform": "linux64-pgo", 03:33:02 INFO - "builduid": "d739623750ad4ba4b489649eee05a4dd", 03:33:02 INFO - "slavebuilddir": "test" 03:33:02 INFO - } 03:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:33:02 INFO - Running post-action listener: _resource_record_post_action 03:33:02 INFO - [mozharness: 2016-10-12 10:33:02.283133Z] Finished read-buildbot-config step (success) 03:33:02 INFO - [mozharness: 2016-10-12 10:33:02.283232Z] Running download-and-extract step. 03:33:02 INFO - Running pre-action listener: _resource_record_pre_action 03:33:02 INFO - Running main action method: download_and_extract 03:33:02 INFO - mkdir: /builds/slave/test/build/tests 03:33:02 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')]} 03:33:02 INFO - trying https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:02 INFO - Downloaded 1361 bytes. 03:33:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:02 INFO - Using the following test package requirements: 03:33:02 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:02 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:02 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:33:02 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'jsshell-linux-x86_64.zip'], 03:33:02 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:02 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:02 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:33:02 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:33:02 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:02 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:33:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:02 INFO - Fetch https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:33:03 INFO - Expected file size: 21907146 03:33:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:33:08 INFO - Expected file size: 21907146 03:33:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:13 INFO - Fetch https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:33:13 INFO - Expected file size: 14414059 03:33:14 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')]} 03:33:14 INFO - trying https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:14 INFO - Downloading https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:16 INFO - Downloaded 63957849 bytes. 03:33:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:16 INFO - mkdir: /builds/slave/test/properties 03:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:16 INFO - Contents: 03:33:16 INFO - build_url:https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:17 INFO - Running post-action listener: _resource_record_post_action 03:33:17 INFO - Running post-action listener: set_extra_try_arguments 03:33:17 INFO - [mozharness: 2016-10-12 10:33:17.499070Z] Finished download-and-extract step (success) 03:33:17 INFO - [mozharness: 2016-10-12 10:33:17.499297Z] Running populate-webroot step. 03:33:17 INFO - Running pre-action listener: _resource_record_pre_action 03:33:17 INFO - Running main action method: populate_webroot 03:33:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:17 INFO - '--tppagecycles', 03:33:17 INFO - '7'], 03:33:17 INFO - 'tests': ['tsvgm']}}, 03:33:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['damp', 'tps']}, 03:33:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'tests': ['damp', 'tps']}, 03:33:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['dromaeo_dom']}, 03:33:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['basic_compositor_video']}, 03:33:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['a11yr', 03:33:17 INFO - 'ts_paint', 03:33:17 INFO - 'tpaint', 03:33:17 INFO - 'sessionrestore', 03:33:17 INFO - 'sessionrestore_no_auto_restore', 03:33:17 INFO - 'tabpaint']}, 03:33:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['tsvgx', 03:33:17 INFO - 'tsvgr_opacity', 03:33:17 INFO - 'tart', 03:33:17 INFO - 'tscrollx', 03:33:17 INFO - 'cart']}, 03:33:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:17 INFO - 'tsvgr_opacity', 03:33:17 INFO - 'tart', 03:33:17 INFO - 'tscrollx', 03:33:17 INFO - 'cart']}, 03:33:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'talos_options': ['--disable-e10s'], 03:33:17 INFO - 'tests': ['tp5o']}, 03:33:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'tests': ['tp5o']}, 03:33:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'talos_options': ['--disable-e10s', 03:33:17 INFO - '--xperf_path', 03:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:17 INFO - 'tests': ['tp5n']}, 03:33:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:17 INFO - 'talos_options': ['--xperf_path', 03:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:17 INFO - 'tests': ['tp5n']}}, 03:33:17 INFO - 'talos.zip': {'path': '', 03:33:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:17 INFO - Running post-action listener: _resource_record_post_action 03:33:17 INFO - [mozharness: 2016-10-12 10:33:17.519745Z] Finished populate-webroot step (success) 03:33:17 INFO - [mozharness: 2016-10-12 10:33:17.519833Z] Running create-virtualenv step. 03:33:17 INFO - Running pre-action listener: _resource_record_pre_action 03:33:17 INFO - Running main action method: create_virtualenv 03:33:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:17 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 03:33:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:17 INFO - Using real prefix '/usr' 03:33:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:20 INFO - Installing pip.................done. 03:33:20 INFO - Return code: 0 03:33:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:20 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')]} 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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')]} 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:20 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 03:33:20 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 03:33:20 INFO - Using env: {'DISPLAY': ':0', 03:33:20 INFO - 'HOME': '/home/cltbld', 03:33:20 INFO - 'LANG': 'en_US.UTF-8', 03:33:20 INFO - 'LANGUAGE': 'en_US:en', 03:33:20 INFO - 'LOGNAME': 'cltbld', 03:33:20 INFO - 'MAIL': '/var/mail/cltbld', 03:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:20 INFO - 'MOZ_NO_REMOTE': '1', 03:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:20 INFO - 'NO_EM_RESTART': '1', 03:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:20 INFO - 'PWD': '/builds/slave/test', 03:33:20 INFO - 'SHELL': '/bin/bash', 03:33:20 INFO - 'SHLVL': '1', 03:33:20 INFO - 'TERM': 'linux', 03:33:20 INFO - 'TMOUT': '86400', 03:33:20 INFO - 'USER': 'cltbld', 03:33:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:20 INFO - '_': '/tools/buildbot/bin/python'} 03:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:20 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 03:33:20 INFO - Cleaning up... 03:33:20 INFO - Return code: 0 03:33:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:20 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')]} 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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')]} 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:20 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:20 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 03:33:20 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 03:33:20 INFO - Using env: {'DISPLAY': ':0', 03:33:20 INFO - 'HOME': '/home/cltbld', 03:33:20 INFO - 'LANG': 'en_US.UTF-8', 03:33:20 INFO - 'LANGUAGE': 'en_US:en', 03:33:20 INFO - 'LOGNAME': 'cltbld', 03:33:20 INFO - 'MAIL': '/var/mail/cltbld', 03:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:20 INFO - 'MOZ_NO_REMOTE': '1', 03:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:20 INFO - 'NO_EM_RESTART': '1', 03:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:20 INFO - 'PWD': '/builds/slave/test', 03:33:20 INFO - 'SHELL': '/bin/bash', 03:33:20 INFO - 'SHLVL': '1', 03:33:20 INFO - 'TERM': 'linux', 03:33:20 INFO - 'TMOUT': '86400', 03:33:20 INFO - 'USER': 'cltbld', 03:33:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:20 INFO - '_': '/tools/buildbot/bin/python'} 03:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:20 INFO - Downloading/unpacking psutil>=3.1.1 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:22 INFO - Installing collected packages: psutil 03:33:22 INFO - Running setup.py install for psutil 03:33:22 INFO - building 'psutil._psutil_linux' extension 03:33:22 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 03:33:22 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 03:33:22 INFO - building 'psutil._psutil_posix' extension 03:33:22 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 03:33:22 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 03:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:23 INFO - Successfully installed psutil 03:33:23 INFO - Cleaning up... 03:33:23 INFO - Return code: 0 03:33:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:33:23 INFO - Using env: {'DISPLAY': ':0', 03:33:23 INFO - 'HOME': '/home/cltbld', 03:33:23 INFO - 'LANG': 'en_US.UTF-8', 03:33:23 INFO - 'LANGUAGE': 'en_US:en', 03:33:23 INFO - 'LOGNAME': 'cltbld', 03:33:23 INFO - 'MAIL': '/var/mail/cltbld', 03:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:23 INFO - 'MOZ_NO_REMOTE': '1', 03:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:23 INFO - 'NO_EM_RESTART': '1', 03:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:23 INFO - 'PWD': '/builds/slave/test', 03:33:23 INFO - 'SHELL': '/bin/bash', 03:33:23 INFO - 'SHLVL': '1', 03:33:23 INFO - 'TERM': 'linux', 03:33:23 INFO - 'TMOUT': '86400', 03:33:23 INFO - 'USER': 'cltbld', 03:33:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:23 INFO - '_': '/tools/buildbot/bin/python'} 03:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:25 INFO - Installing collected packages: mozsystemmonitor 03:33:25 INFO - Running setup.py install for mozsystemmonitor 03:33:25 INFO - Successfully installed mozsystemmonitor 03:33:25 INFO - Cleaning up... 03:33:25 INFO - Return code: 0 03:33:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:33:25 INFO - Using env: {'DISPLAY': ':0', 03:33:25 INFO - 'HOME': '/home/cltbld', 03:33:25 INFO - 'LANG': 'en_US.UTF-8', 03:33:25 INFO - 'LANGUAGE': 'en_US:en', 03:33:25 INFO - 'LOGNAME': 'cltbld', 03:33:25 INFO - 'MAIL': '/var/mail/cltbld', 03:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:25 INFO - 'MOZ_NO_REMOTE': '1', 03:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:25 INFO - 'NO_EM_RESTART': '1', 03:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:25 INFO - 'PWD': '/builds/slave/test', 03:33:25 INFO - 'SHELL': '/bin/bash', 03:33:25 INFO - 'SHLVL': '1', 03:33:25 INFO - 'TERM': 'linux', 03:33:25 INFO - 'TMOUT': '86400', 03:33:25 INFO - 'USER': 'cltbld', 03:33:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:25 INFO - '_': '/tools/buildbot/bin/python'} 03:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:25 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 03:33:25 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 03:33:25 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 03:33:25 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 03:33:25 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 03:33:25 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 03:33:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:27 INFO - warning: no files found matching '*.txt' 03:33:27 INFO - no previously-included directories found matching 'build' 03:33:27 INFO - no previously-included directories found matching 'dist' 03:33:27 INFO - no previously-included directories found matching '.git*' 03:33:27 INFO - Installing collected packages: jsonschema, functools32 03:33:27 INFO - Running setup.py install for functools32 03:33:27 INFO - warning: no files found matching '*.txt' 03:33:27 INFO - no previously-included directories found matching 'build' 03:33:27 INFO - no previously-included directories found matching 'dist' 03:33:27 INFO - no previously-included directories found matching '.git*' 03:33:27 INFO - Successfully installed jsonschema functools32 03:33:27 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:33:28 INFO - Using env: {'DISPLAY': ':0', 03:33:28 INFO - 'HOME': '/home/cltbld', 03:33:28 INFO - 'LANG': 'en_US.UTF-8', 03:33:28 INFO - 'LANGUAGE': 'en_US:en', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MAIL': '/var/mail/cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SHLVL': '1', 03:33:28 INFO - 'TERM': 'linux', 03:33:28 INFO - 'TMOUT': '86400', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - '_': '/tools/buildbot/bin/python'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:28 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:33:28 INFO - Using env: {'DISPLAY': ':0', 03:33:28 INFO - 'HOME': '/home/cltbld', 03:33:28 INFO - 'LANG': 'en_US.UTF-8', 03:33:28 INFO - 'LANGUAGE': 'en_US:en', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MAIL': '/var/mail/cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SHLVL': '1', 03:33:28 INFO - 'TERM': 'linux', 03:33:28 INFO - 'TMOUT': '86400', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - '_': '/tools/buildbot/bin/python'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - Downloading docopt-0.6.1.tar.gz 03:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:31 INFO - Running setup.py install for blobuploader 03:33:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:31 INFO - Running setup.py install for requests 03:33:31 INFO - Running setup.py install for docopt 03:33:31 INFO - Successfully installed blobuploader requests docopt 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:31 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 03:33:31 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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:31 INFO - Running setup.py (path:/tmp/pip-Xl2qnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Running setup.py (path:/tmp/pip-b0BMy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Running setup.py (path:/tmp/pip-hB6FSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Running setup.py (path:/tmp/pip-0BAihB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Running setup.py (path:/tmp/pip-WBX9bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:32 INFO - Running setup.py (path:/tmp/pip-xBgrUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:32 INFO - Running setup.py (path:/tmp/pip-e1qsKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:32 INFO - Running setup.py (path:/tmp/pip-qTkwhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:32 INFO - Running setup.py (path:/tmp/pip-Z5YPY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:32 INFO - Running setup.py (path:/tmp/pip-MU8lJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:32 INFO - Running setup.py (path:/tmp/pip-De7OLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:32 INFO - Running setup.py (path:/tmp/pip-ZgMw5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:32 INFO - Running setup.py (path:/tmp/pip-UnL1Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:32 INFO - Running setup.py (path:/tmp/pip-7C8Gkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Running setup.py (path:/tmp/pip-3Z53GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Running setup.py (path:/tmp/pip-CyYzpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Running setup.py (path:/tmp/pip-UzYWDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:33 INFO - Running setup.py install for manifestparser 03:33:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Running setup.py install for mozcrash 03:33:33 INFO - Running setup.py install for mozdebug 03:33:33 INFO - Running setup.py install for mozdevice 03:33:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Running setup.py install for mozfile 03:33:33 INFO - Running setup.py install for mozhttpd 03:33:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Running setup.py install for mozinfo 03:33:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Running setup.py install for mozInstall 03:33:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozleak 03:33:34 INFO - Running setup.py install for mozlog 03:33:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for moznetwork 03:33:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozprocess 03:33:34 INFO - Running setup.py install for mozprofile 03:33:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozrunner 03:33:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozscreenshot 03:33:34 INFO - Running setup.py install for moztest 03:33:34 INFO - Running setup.py install for mozversion 03:33:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:35 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 03:33:35 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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:35 INFO - Running setup.py (path:/tmp/pip-keZsUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:35 INFO - Running setup.py (path:/tmp/pip-wT0rgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:35 INFO - Running setup.py (path:/tmp/pip-ovp1ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:35 INFO - Running setup.py (path:/tmp/pip-kDGaHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:35 INFO - Running setup.py (path:/tmp/pip-OTQaYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:35 INFO - Running setup.py (path:/tmp/pip-vjeFmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:35 INFO - Running setup.py (path:/tmp/pip-8z8zL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:35 INFO - Running setup.py (path:/tmp/pip-iPFkpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:35 INFO - Running setup.py (path:/tmp/pip-aKP89Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:35 INFO - Running setup.py (path:/tmp/pip-w3MaUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:35 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)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:35 INFO - Running setup.py (path:/tmp/pip-w4QH2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:36 INFO - Running setup.py (path:/tmp/pip-LOw7bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:36 INFO - Running setup.py (path:/tmp/pip-7oCbjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:36 INFO - Running setup.py (path:/tmp/pip-E0L0dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:36 INFO - Running setup.py (path:/tmp/pip-dPMEBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:36 INFO - Running setup.py (path:/tmp/pip-MQ4fa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:36 INFO - Running setup.py (path:/tmp/pip-6N1aRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:36 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)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:36 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)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:38 INFO - Downloading blessings-1.6.tar.gz 03:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:38 INFO - Installing collected packages: blessings 03:33:38 INFO - Running setup.py install for blessings 03:33:38 INFO - Successfully installed blessings 03:33:38 INFO - Cleaning up... 03:33:38 INFO - Return code: 0 03:33:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:38 INFO - Reading from file tmpfile_stdout 03:33:38 INFO - Current package versions: 03:33:38 INFO - argparse == 1.2.1 03:33:38 INFO - blessings == 1.6 03:33:38 INFO - blobuploader == 1.2.4 03:33:38 INFO - docopt == 0.6.1 03:33:38 INFO - functools32 == 3.2.3-2 03:33:38 INFO - jsonschema == 2.5.1 03:33:38 INFO - manifestparser == 1.1 03:33:38 INFO - mozInstall == 1.12 03:33:38 INFO - mozcrash == 0.17 03:33:38 INFO - mozdebug == 0.1 03:33:38 INFO - mozdevice == 0.48 03:33:38 INFO - mozfile == 1.2 03:33:38 INFO - mozhttpd == 0.7 03:33:38 INFO - mozinfo == 0.9 03:33:38 INFO - mozleak == 0.1 03:33:38 INFO - mozlog == 3.4 03:33:38 INFO - moznetwork == 0.27 03:33:38 INFO - mozprocess == 0.23 03:33:38 INFO - mozprofile == 0.28 03:33:38 INFO - mozrunner == 6.12 03:33:38 INFO - mozscreenshot == 0.1 03:33:38 INFO - mozsystemmonitor == 0.3 03:33:38 INFO - moztest == 0.7 03:33:38 INFO - mozversion == 1.4 03:33:38 INFO - psutil == 3.1.1 03:33:38 INFO - requests == 1.2.3 03:33:38 INFO - wsgiref == 0.1.2 03:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:38 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:38 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 03:33:38 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 03:33:38 INFO - Using env: {'DISPLAY': ':0', 03:33:38 INFO - 'HOME': '/home/cltbld', 03:33:38 INFO - 'LANG': 'en_US.UTF-8', 03:33:38 INFO - 'LANGUAGE': 'en_US:en', 03:33:38 INFO - 'LOGNAME': 'cltbld', 03:33:38 INFO - 'MAIL': '/var/mail/cltbld', 03:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:38 INFO - 'MOZ_NO_REMOTE': '1', 03:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:38 INFO - 'NO_EM_RESTART': '1', 03:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:38 INFO - 'PWD': '/builds/slave/test', 03:33:38 INFO - 'SHELL': '/bin/bash', 03:33:38 INFO - 'SHLVL': '1', 03:33:38 INFO - 'TERM': 'linux', 03:33:38 INFO - 'TMOUT': '86400', 03:33:38 INFO - 'USER': 'cltbld', 03:33:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:38 INFO - '_': '/tools/buildbot/bin/python'} 03:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 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)) 03:33:39 INFO - Cleaning up... 03:33:39 INFO - Return code: 0 03:33:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:39 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')]} 03:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:39 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')]} 03:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:39 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 0x7f6c4d205f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', '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 03:33:39 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 03:33:39 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 03:33:39 INFO - Using env: {'DISPLAY': ':0', 03:33:39 INFO - 'HOME': '/home/cltbld', 03:33:39 INFO - 'LANG': 'en_US.UTF-8', 03:33:39 INFO - 'LANGUAGE': 'en_US:en', 03:33:39 INFO - 'LOGNAME': 'cltbld', 03:33:39 INFO - 'MAIL': '/var/mail/cltbld', 03:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:39 INFO - 'MOZ_NO_REMOTE': '1', 03:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:39 INFO - 'NO_EM_RESTART': '1', 03:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:39 INFO - 'PWD': '/builds/slave/test', 03:33:39 INFO - 'SHELL': '/bin/bash', 03:33:39 INFO - 'SHLVL': '1', 03:33:39 INFO - 'TERM': 'linux', 03:33:39 INFO - 'TMOUT': '86400', 03:33:39 INFO - 'USER': 'cltbld', 03:33:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:39 INFO - '_': '/tools/buildbot/bin/python'} 03:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:39 INFO - Cleaning up... 03:33:39 INFO - Return code: 0 03:33:39 INFO - Running post-action listener: _resource_record_post_action 03:33:39 INFO - Running post-action listener: _start_resource_monitoring 03:33:39 INFO - Starting resource monitoring. 03:33:39 INFO - [mozharness: 2016-10-12 10:33:39.355167Z] Finished create-virtualenv step (success) 03:33:39 INFO - [mozharness: 2016-10-12 10:33:39.355625Z] Running install step. 03:33:39 INFO - Running pre-action listener: _resource_record_pre_action 03:33:39 INFO - Running main action method: install 03:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:39 INFO - Reading from file tmpfile_stdout 03:33:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:39 INFO - Reading from file tmpfile_stdout 03:33:39 INFO - Output received: 03:33:39 INFO - Usage: mozinstall [options] installer 03:33:39 INFO - Options: 03:33:39 INFO - -h, --help show this help message and exit 03:33:39 INFO - -d DEST, --destination=DEST 03:33:39 INFO - Directory to install application into. [default: 03:33:39 INFO - "/builds/slave/test"] 03:33:39 INFO - --app=APP Application being installed. [default: firefox] 03:33:39 INFO - mkdir: /builds/slave/test/build/application 03:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:55 INFO - Reading from file tmpfile_stdout 03:33:55 INFO - Output received: 03:33:55 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:55 INFO - Running post-action listener: _resource_record_post_action 03:33:55 INFO - [mozharness: 2016-10-12 10:33:55.615269Z] Finished install step (success) 03:33:55 INFO - [mozharness: 2016-10-12 10:33:55.615513Z] Running run-tests step. 03:33:55 INFO - Running pre-action listener: _resource_record_pre_action 03:33:55 INFO - Running main action method: run_tests 03:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:55 INFO - Python 2.7.3 03:33:55 INFO - Return code: 0 03:33:55 INFO - grabbing minidump binary from tooltool 03:33: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')]} 03:33:55 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 0x1bc6f60>, '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 0x1bc7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:55 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 03:33:55 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 03:33:55 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 03:33:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:55 INFO - Return code: 0 03:33:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 03:33:55 INFO - Using env: {'DISPLAY': ':0', 03:33:55 INFO - 'HOME': '/home/cltbld', 03:33:55 INFO - 'LANG': 'en_US.UTF-8', 03:33:55 INFO - 'LANGUAGE': 'en_US:en', 03:33:55 INFO - 'LOGNAME': 'cltbld', 03:33:55 INFO - 'MAIL': '/var/mail/cltbld', 03:33:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:55 INFO - 'MOZ_NO_REMOTE': '1', 03:33:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:55 INFO - 'NO_EM_RESTART': '1', 03:33:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:55 INFO - 'PWD': '/builds/slave/test', 03:33:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:55 INFO - 'SHELL': '/bin/bash', 03:33:55 INFO - 'SHLVL': '1', 03:33:55 INFO - 'TERM': 'linux', 03:33:55 INFO - 'TMOUT': '86400', 03:33:55 INFO - 'USER': 'cltbld', 03:33:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530', 03:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:55 INFO - '_': '/tools/buildbot/bin/python'} 03:33:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:33:55 INFO - mozversion application_buildid: 20161012005247 03:33:55 INFO - mozversion application_changeset: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 03:33:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:55 INFO - mozversion application_name: Firefox 03:33:55 INFO - mozversion application_remotingname: firefox-dev 03:33:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:55 INFO - mozversion application_vendor: Mozilla 03:33:55 INFO - mozversion application_version: 51.0a2 03:33:55 INFO - mozversion platform_buildid: 20161012005247 03:33:55 INFO - mozversion platform_changeset: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 03:33:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:55 INFO - mozversion platform_version: 51.0a2 03:33:55 INFO - using testdate: 1476268435 03:33:55 INFO - actual date: 1476268435 03:33:55 INFO - starting webserver on 'localhost:33569' 03:33:55 INFO - SUITE-START | Running 2 tests 03:33:55 INFO - TEST-START | dromaeo_css 03:33:55 INFO - operating with platform_type : linux_ 03:33:55 INFO - Initialising browser for dromaeo_css test... 03:33:55 INFO - TEST-INFO | started process 7942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM59pVq/profile http://localhost:33569/getInfo.html) 03:33:59 INFO - PROCESS | 7942 | __metrics Screen width/height:1600/1200 03:33:59 INFO - PROCESS | 7942 | colorDepth:24 03:33:59 INFO - PROCESS | 7942 | Browser inner width/height: 1024/697 03:33:59 INFO - PROCESS | 7942 | __metrics 03:34:00 INFO - PROCESS | 7942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:00 INFO - PROCESS | 7942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:01 INFO - PROCESS | 7942 | console.error: PushService: 03:34:01 INFO - PROCESS | 7942 | stateChangeProcessEnqueue: Error transitioning state 03:34:01 INFO - PROCESS | 7942 | UnknownError 03:34:01 INFO - TEST-INFO | 7942: exit 0 03:34:01 INFO - Browser initialized. 03:34:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:01 INFO - TEST-INFO | started process 8031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM59pVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:13 INFO - PROCESS | 8031 | RSS: Main: 144121856 03:34:13 INFO - PROCESS | 8031 | 03:35:04 INFO - PROCESS | 8031 | 1476268504397 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] 03:37:13 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33569/tests/dromaeo/cssquery-ext.html) 03:37:14 INFO - PROCESS | 8031 | RSS: Main: 251138048 03:37:14 INFO - PROCESS | 8031 | 03:40:17 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-ext.html (next: http://localhost:33569/tests/dromaeo/cssquery-jquery.html) 03:40:17 INFO - PROCESS | 8031 | RSS: Main: 224120832 03:40:17 INFO - PROCESS | 8031 | 03:43:19 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33569/tests/dromaeo/cssquery-mootools.html) 03:43:20 INFO - PROCESS | 8031 | RSS: Main: 220508160 03:43:20 INFO - PROCESS | 8031 | 03:46:22 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33569/tests/dromaeo/cssquery-prototype.html) 03:46:22 INFO - PROCESS | 8031 | RSS: Main: 224022528 03:46:22 INFO - PROCESS | 8031 | 03:49:25 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33569/tests/dromaeo/cssquery-yui.html) 03:49:25 INFO - PROCESS | 8031 | RSS: Main: 178778112 03:49:25 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | Cycle 1(1): loaded http://localhost:33569/tests/dromaeo/cssquery-yui.html (next: http://localhost:33569/tests/dromaeo/cssquery-dojo.html) 03:52:28 INFO - PROCESS | 8031 | RSS: Main: 263114752 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | __start_tp_report 03:52:28 INFO - PROCESS | 8031 | _x_x_mozilla_page_load 03:52:28 INFO - PROCESS | 8031 | _x_x_mozilla_page_load_details 03:52:28 INFO - PROCESS | 8031 | |i|pagename|runs| 03:52:28 INFO - PROCESS | 8031 | |0;dojo.html;3121.1416860363406;3151.2752067024576;3152.55864179015;3162.636296825866;3191.776575639706;5480.5341545968595;5503.449655034495;5527.419620939793;5550.555955523559;5554.444555544444;5543.6119471637;5572.832815015546;5591.077472217079;5597.412271711472;5607.130894711327;5060.595152387809;5060.645754797166;5105.310783044279;5125.333706618135;5149.794008239666;4998.5501304882555;5115.181570948649;5154.098032844237;5154.74226288686;5164.922526162091;4971.328870602477;5042.798288068473;5051.191809310511;5058.873528161788;5067.670601410915;5098.337216161894;5119.1809310510325;5131.7690703918415;5159.5614372778355;5164.2770012198325;4998.400191976986;5086.3133476980875;5127.743612819344;5143.7685304161405;5165.483451654842;5448.182772584105;5501.14732216503;5520;5526.834194974157;5564.221009058735;5929.733162007677;5941.079132734433;5950.345461999176;6025.246844144482;6031.1254868044325;6066.817995460143;6070.726817293188;6081.452669259744;6097.7865774697675;6102.3287438382185;5399.7030163341;5452.318460192476;5537.307836520435;5560.138178582326;5594;6114.205153330127;6128.571000030044;6130.233720784902;6134.693265336805;6149.0776383542825;5669.121286200645;5904.645721256738;5912.260967379078;5915.37888521699;5922.881542369215;5791.536677065825;5923.881522369528;5971.4924231439945;5972.701364931736;6079.240094988127;5990.131430942576;6018.608790428696;6024.969875150684;6026.337102918676;6032.788852390233;5976.61152025117;6007.879842403215;6020.759169633166;6023.066424704178;6077.270727512727;4496.752678602708;4540.137373899015;4597.057603191338;4652.185867473178;4662.463816661128;4139.089400331922;4146.937795933063;4147.502299724052;4157.147784704129;4178.811953462041;5756.395578464201;5777.566682498746;5795;5798.101294299306;5798.1302804579655;5810.709464526757;5881.235439392852;5955.493783028404;6003.759849605967;6106.4809491192855;5757.481826635623;5765.596408251382;5767.798127065533;5772.855678608068;5781.248437703071;5041.672291301127;5045.772940217699;5057.342545469065;5060.2662613920775;5081.644284900021;5899.616524925866;6030.999999999913;6100.145979562776;6240.032794916704;6243.469305109116;6027.608205466806;6066.181065556093;6091.329953705177;6096;6100.389961003864;6177.722002509988;6202.534809889186;6226.937730622817;6234.407731265523;6259.311475737574;5733.483986441073;5779.739911703899;5856.707164641836;5982.192404025401;6017.18767966319;5974.522038237017;6026.638401695737;6048.183495228264;6051.818445446644;6088.238970128734;5814.622049566765;5814.912776308274;5877.882442351214;5884.558658100746;5891.11633254998;5618.157276408571;5670.5180059695385;5872.647641141545;5886.58793884424;5887.116932460165;5787.971060144672;5791.884162316815;5814.505767009682;5816.621919575214;5894.410558944071;5890.204822348928;5963.194968679173;5964.373740757332;5966.820995370146;5968.940310597012;5502.147167189092;5531.834044978657;5793.884122317446;5806.9419305806405;5814.215080964185 03:52:28 INFO - PROCESS | 8031 | |1;ext.html;590.108935507384;604.9806076760657;637.8756142552202;662.6786008785741;663.5952069237767;35261.647383526186;35908.46137307942;37618.43572346417;37668;37687;38258.80870595643;48771.26843097356;49575;49718;52727.73636131814;9147.634094636207;9211.170994610484;9292.163705266525;9292.210162136227;9294.953525232364;8897.555122243893;8961.417507862001;8971.102889711043;8984.8652270216;8988.460692358447;8572.657093716243;8741.169588889044;10991.725206869813;11195.66413007607;11205.943970280137;11184.825593312707;11200.439978001148;11215.439228038565;11240.269382490113;11250.3812290324;8373.288270497014;10884.129269658408;10966.670999870017;10982.670519884416;10995.395253261067;35849.28301433957;36121.81939090314;36250.63749362499;43815.78092109551;44736.55263447356;3861.8455261789495;3873.8140748910646;3894.2990261752875;4037.4145748866545;4072.124493233969;33375.66624333774;34125.48811767826;34325.485117723256;34527.30945381078;36096.81951590251;4667.4632417272105;4682.976585117052;4718.834840780591;4751;4757.571818536314;368049;369057;369132;370023;370767;62990.68504657447;63543;63564.68217658882;63625.681871591274;63641.36358636447;60882.39117608856;62127.689361552904;67128;67424.6628766853;68759;18512.16695248717;19169.233230670896;19183.904080479788;19200.61598768017;19292.1318540666;14212.644683882985;14322.785158222636;14329.35517901697;14337.928310358382;14412.423503059761;16795.41216057432;17187;18208.36270730518;18459.907700461412;18562.721559176352;6591.934080659228;6952.652367381712;6996.230414654384;7012.403945664573;7129.251428600026;989.6684610655367;1028.5320179318542;1034.3948789957808;1051.9000694933968;1087.255230167338;33798.324033519195;33843.66156338454;34124;34262.31475370529;34421.82789086038;1160.4023927677254;1179.3159967218992;1199.7960346741074;1212.7271363943041;1250.7936190528642;17884.642307153783;18019.27922883096;18048.639027219644;18051.54871128206;18113.637727245383;542596;545282;547133;547470;548397;55305;56291.71854140703;60600;62251.06623400562;62449.063264051074;1387.8889688824668;1400.7338605665095;1401.978970315446;1439.9064060836013;1452.3319273134266;33075.50386744153;35463.46804797982;35565.86141068022;35623.64376356307;35731.285374291845;55490;55733.721331393084;55860.44139558553;55866;56051.43948560462;502812;508254;509468;518859;520635;29800.254993625334;29803.254918627208;29816.850915745283;30040.699593003792;30158.547621785252;49649.75175124246;50071.499285006685;50132;50208;50293.49706502888;42562.5743742571;42623.57376426196;42722.5727742731;42985.355219672354;43894.34158487561;41280.38079428751;42098;42560.78719606382;43758.34362484629;43764;39511.60488395079;40225;40875;41148.1770364597;41350.37974430326;36020.81989590035;37274.813625931696;37993.4300985491;38804.41793373045;38853.41719874261;29009.274768130967;29305.706942930297;29484.852575736983;29529.85235073811;29535.704642953297 03:52:28 INFO - PROCESS | 8031 | |2;jquery.html;387.36472185615577;426.1710972159151;428.5679967328898;436.2278766583148;449.5032988547655;16020.519384418458;19918.103685334176;19963.30128445503;20846.374608761722;21739.23912663057;19786.505337366572;20336.898315508402;20385.59228815423;20389.08249128789;20622.48443788906;5717.599768016241;5797.536197104232;5849.912251316212;5882.323532793719;5884.382139875315;5711.200431939532;5816.4474374934525;5821.56338274629;5824.86415149044;5826.300843898717;5626.746796394172;5834.883302333972;5863.501602363783;5863.79476718315;5864.648121112747;5798.092068114945;5822.0684690449325;5862.472377486004;5865.266841644773;5872.207252020965;5138.3577052868395;5301.522862942315;5307.150855863082;5307.9734601326745;5308.177232528964;24744.50510989788;24972;24998.875005624854;25255.36861578475;25467;2580.8580528070947;2632.3682316244153;2652.575587905945;2867.1828528869382;2994.3262765877503;15041.774373384407;15539.378424862993;15546.61133471661;15765.763513547307;15786.763198552031;1984.2559040359865;2023.1401654296865;2040.1271354787386;2041.469218003315;2083.9889506626178;86602;90583;91261.54369228178;91464.54267728618;91645.54177229138;10682.1988350874;10912.67261982126;11070.391128487849;11267.38029408374;11501;16592.668146637;16652.250648720837;16656.916715416344;16666.916665416837;16709.248083836013;8784.165504277084;8817.426867253607;8973.37186396946;9026.368154229142;9175.265978721687;8599.61301741423;8601.612927418157;8649.654013839501;8775.561221938877;8790.42862213954;7061.293870613001;7076.681549330293;7199.172095209118;7223.061002069802;7284.745033923788;1962.8037196280259;2010.3667344786638;2014.325201057662;2021.1208124465904;2064.576761763835;872.6683860133109;1038.864947556828;1041.9739506512246;1088.172988528708;1090.9509072091776;20958.16167353319;21126.788732112484;21291.36125916225;21352;21478.355649330544;1062.2033474893828;1071.6677829872765;1089.4334945828125;1090.0026475774578;1124.8650161980615;11143.219974601861;12159.331236781885;12160;12326.32205228703;12392.194507356993;460891;463675;469045;481426;483050;87179;90955;91370.54314728516;92137.53931230301;93791;1084.9783004340027;1101.0475938313461;1102.47081400928;1102.9338239705644;1111.8610173728284;18528.258869645604;18722.625547489246;19060.23759049678;19069.809301906804;19134.138963746387;42140.157196855274;43211.783941080095;43291.35062973995;43427.78286108549;43562.56437435712;58327.4167258322;58517;58709.70645146747;59194;61886.381136188065;8129.105798362294;8190.918090819254;8314.41799074059;8418.831623367376;8963.238124759468;9849.556769945226;13069.934650326688;13491.595252142451;13639.454421823017;13874.236916969663;7259.6370181491775;11331.150163737588;12165.148439609497;12220.450079746255;12235.87764122383;11282.774344513227;11459.19785614999;11480.540778368771;11781;11794.705132371759;12058.457369418573;12172.14794964344;12185.268883866996;12407.441665125272;12503.374831258583;8037.075736290401;8328.375371847014;8406.117357677356;8426.5786710663;8447.66209351619;12127.878721212675;12181.69545761363;12219.572314968933;12373.62879113628;12543.435545400296 03:52:28 INFO - PROCESS | 8031 | |3;mootools.html;1426.2227086238;1531.77023446483;1555.5022392834294;1718.3899715600962;1844.419008012476;8204;8778.078301778309;9055.818883622323;9057.864132038025;9289.535523223845;9036.141566551183;9095.45427274364;9100.726978190665;9108.089191080906;9120.224780893615;2108.441263065289;2179.967300490494;2503.236512863576;2531.354504601324;2540.898364065444;2351.3886389538757;2409.734929157791;2427.0898413095088;2433.3308340206495;2436.2325867351815;2346.296111166652;2346.6480027995767;2353.4351755578623;2384.9761502384927;2435.610302351624;2333.6266197408504;2370.1941339944415;2377.108584280895;2379.262428647125;2413.553492603874;2565.1278565287707;2576.381668399589;2593.3775893785355;2593.9092131775296;2595.779358754508;9488.478133702643;9548.856767148498;9582.664606738801;9583.424994500352;9589.376690515093;5519.641223320512;5694.402087780765;5742;5752.913706294409;5753.856153596152;3589.4795254688183;3590.138366791977;3619.384704600198;3625.093726568358;3686.64976827201;1162.5466068233395;1193.1409385242698;1201.411308458849;1217.9634610961684;1219.5182902753363;13208.735825283537;13253.403596838165;13323.800142997863;13369;13388.93305533466;4809.663323567317;4815.061063092733;4874.951250487521;4891.510848915151;4994.425641051325;10204.744881378025;10324.741881452874;10332.638357657446;10342.534585943651;10351.741206469747;5518.862028449241;5552.86117847049;5556.638818476867;5620.4660557247;5627.493525582717;4397.648188144941;4566.383538222364;5180.766865491062;5262.97368513155;5275.920861187085;4055.533613634411;4069.877903662895;4163.7293575917465;4169.395437661522;4185.539590645027;1230.317173968456;1245.6636708088765;1251.386820457969;1259.250745806244;1259.622113366005;990.1633120013721;994.9900500994897;1029.8712660917386;1038.2576457832536;1045.1586472889396;6050.334463209044;6586.341365863471;6611.074449577063;6727.966360168168;6984.301569843076;1017.9694609161737;1025.415513157508;1055.2402270365324;1058.1481907064733;1074.2426589254712;4290.399344091829;4318.460192475941;4410.69125161242;4475.462944446687;4523.547645235451;11236.325820450798;11645.475953582109;11668.94165529167;11673.241239319417;11736.647900562997;10769.461526923778;11083.556657733601;11548.480318385693;11556.653300401002;11599.362035088152;8864.778380540409;9047.140521650434;9055.68305109318;9062.184403403593;9062.728118156467;6540.771073012422;6569.146011018537;6588.110605068446;6592.901106483502;6751.56114852533;10071.295009349275;10808.891911081104;10859.294145880493;10904.890951090387;11018.173636977099;10330.845037324296;10442.060214580724;10566.8414973777;10567.207459440418;10649.627263045757;7949.960250198712;8209.13804050566;8819.911800882166;8873.157050080232;9065.95467022687;9178.357514974155;9335.346525743133;9345.112214339626;9347.579358929;9359.391639543408;8188.959055204924;8214.13751556078;8322.08457069734;8347.916520834713;8464.915350846413;8078.434509584273;8212.384071194803;8253.009638843378;8271.33829293643;8340.082590914873;7637.809054773675;7654.119776225805;7769.844603107793;7811.921880781119;7847.607619618882;5449.836504904859;5749.770009199585;5837.29952405714;5877.94122058774;5968.910466342922;5323.547498462674;5337;5420.4850539198715;5463;5507.449255074621 03:52:28 INFO - PROCESS | 8031 | |4;prototype.html;353.28812442927506;354.30732917146975;359.6493418916557;363.5691705329185;364.26236870337544;5461.890762184754;5555.30558680165;5558.110702287635;5561.499465048145;5566.582506312027;5220.973895130529;5244.816431424901;5347.7058761768085;5427.158790387496;5509.173623956409;4276.434139516296;4290.1848648756795;4295.518046274046;4299.914001719963;4308.849190278341;4255.553166917475;4280.101178752466;4283.657307415399;4311.805968731414;4317.69776115672;4095.9724936156645;4237.152569486099;4260.786960651971;4264.189803937242;4271.337942618899;4206.095689426757;4225.492940847118;4246.897785596118;4258.6380157686635;4264.104538047014;3754.9624503754885;3755.117547376364;3768.8869333920024;3773.603771603997;3779.90215430436;5231.822839861039;5352;5366.2755528004;5371.731413429313;5414;4896.387951506062;4903.4606193318705;4908.828191013297;4921.606271498272;4928.876778080541;5720.485156335908;5723.914141287884;5757.740901659436;5758.452946970031;5766.452187042224;4017.678585713136;4082.2447847148073;4099.528554216274;4134.751914885086;4135.58644135584;5945.762169513214;5959.910601341026;5968.67172305523;5983.670898100603;5986.610870293461;4225.556316586775;4229.661627069827;4237.936430953539;4241.957580424218;4244.830206791756;4065.715399921977;4253.8723838284905;4273.87178384649;4283.635890949242;4286.657067434598;4878.707277563358;4879.780409881564;4884.95115048852;4890.926636100461;4897.216445368796;5788.450097240755;5798.246227990334;5808.477237048602;5809.593328466966;5812.970935145382;1453.4258967707697;1464.2459133546233;1469;1473.5432016075051;1486.8884833637521;913.9725808225763;939.6335429182624;946.1626460582297;948.3835506920419;952.2667545989549;4892.755362231874;4947.876303092451;4954;4972.5276098770555;4994.825181118644;5194.545527252375;5196.532312091855;5198.2722418861385;5212.635115541876;5217.217417387422;4709.529047095331;4949.257611358325;4970.254461830682;4977.65156439053;5010;2789.693133755285;2791.3719413131885;2804.214819850445;2811.2971757060736;2812;5341.839744807662;5341.946580534222;5373.596980226499;5391.703456309862;5400.945990540123;4953.405591328991;5265.289185959847;5298.576113910955;5336.786528538815;5364.168553874156;5312.654677446031;5320.627556071116;5320.866978325573;5347.598930080259;5352.892942141136;5160.48395160481;5188.481151884781;5191.714455704972;5203.464977831624;5219.895602088013;5132.538071573576;5490.80782172638;5827.475527202572;5919.644821310735;5924.940750592439;6073.726682299219;6129.754809807558;6164.599301045418;6172.814815555541;6187.535934804818;4050.696197785237;4233.80947857341;4240.724352917051;4257.27626303523;4257.808398622132;5876.44173803488;5911.517162791723;5912.201852749996;5923.318818335774;5923.555733319932;5777.566682498746;5785.247917770663;5792.333881603669;5798.594098413239;5807.448292412214;5633.718314084197;5682.289713785777;5698.552375812574;5731.656100633975;5792.652440853562;5726.0838265877255;5731.369549349652;5746.856328591652;5751.396103409249;5757.337906140848;5576.330840299028;5721.141828725725;5756.021476348947;5800;5808.854778630568;5602.411746766531;5614.438556144516;5646.85882852932;5647.830565083054;5651.15232715096 03:52:28 INFO - PROCESS | 8031 | |5;yui.html;802.9036515618124;825.7440193540001;836.8159005018902;841.1546395872148;897.5198268926124;16157.838421615781;17459.214335354907;17473.213705383256;17499.38752143675;17519.12404379781;12248.571300004502;16083.597910052255;16225.26986285617;16399.67200655986;16403.343866245337;721.422861710632;861.7845538615346;875.5709702245917;878.3412440669498;881.1628952495123;872.4198408058634;874.33113668044;875.6803766625168;875.9430637008605;875.9605817738185;813.7233340664174;814.5886327404652;814.861473549498;814.9755507334789;815.1481701621819;748.1657951384194;774.4617490843866;899.4917871402702;925.6066171876926;931.2503434735036;684.9383555480031;685.4961603221628;685.8045457044768;686.2417029182731;686.306830101601;16672.33310667572;16677.416290429897;16698.165091745363;16701.164941752864;16715.164241787985;15846.603834904105;15863.841361586467;15877.206139693084;15916.76124858128;15983.680326393524;14546.4908728194;14556.563303100818;14606.269686515632;14661.266936653125;14710.926445367704;4621.907561848744;4655.7439340836245;4661.743604101773;4695.107929493385;4792.041591681643;83691.5815420925;84487.99999999939;84872.57563712142;85435.5728221361;85674;12213.206141600767;12216.633500994983;12305.323207223688;12359.134860559854;12373.256421094437;23899.641505377433;24114.51770964571;24134.39664008414;24139.275821725376;24165;8736.12638736134;8776.648934042567;8813.823723525493;9043.728688139367;9100.226480749077;5067.341245638044;5076.238564215398;5156.535911767959;5161.73537483319;5202.768063099993;3712.888613341604;3842.9231415371537;3846.673032792188;3847.461355410245;3858.8456461741216;646.8318237258346;647.8218489915216;651.0754728285846;664.1797380235405;666.5367569539221;713.2475238623302;744.3449764207571;751.9097708275042;766.5170942306423;789.1831953927772;9921.553530091163;10284.897151028394;10562.894371056345;10592.470376481298;10890.509927053301;633.8193614819754;638.042935596605;699.192432740186;705.7000774670745;792.397777688949;4735.786889589976;4979.925301120486;5000.099982003201;5030.270610761419;5045.672031317952;97735;129702;130550;131603.02595461076;133844;64368.35631643717;108749.45625271981;109353.45323273492;113516.43241783738;116486.41756791162;65424.67287663531;91219.54390228007;91965;93266.53366733123;94491.58262626066;9205.953970230106;9247.167754902091;9300.837395325585;9515.476648784106;9625.759356016155;57186.14220786608;57571.71214143903;58535.4146458547;58565.707171465576;59884;76271;84597;84979;85249;86726;12508.374581271082;12701.110922235355;13102.279374634487;13175.60473185806;13502.594922152352;13331.133476324008;13459.327033648475;13563.86436135626;13674.93162534181;14509.637259068608;12401.875981240071;12738.936305318413;12782.872171278541;12907.741845162856;13319.66700832487;13018.218906865619;13169.868301317247;13229;14126.50557230492;14309.64225894361;12772.42524086437;14055.437782488585;14255.429782808571;14748.188849612945;16080.115593641995;11923.701907452036;12624.431900564681;13375.130616509896;13488.5279015234;13748.793768093687;13170.539031133865;13497.797533036815;13652.385642646303;13677.521286755315;13838.16970981704 03:52:28 INFO - PROCESS | 8031 | __end_tp_report 03:52:28 INFO - PROCESS | 8031 | __start_cc_report 03:52:28 INFO - PROCESS | 8031 | _x_x_mozilla_cycle_collect,922 03:52:28 INFO - PROCESS | 8031 | __end_cc_report 03:52:28 INFO - PROCESS | 8031 | __startTimestamp1476269548641__endTimestamp 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | ------- Summary: start ------- 03:52:28 INFO - PROCESS | 8031 | Number of tests: 6 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#0] dojo.html Cycles:165 Average:5561.92 Median:5793.88 stddev:642.48 (11.1%) stddev-sans-first:615.26 03:52:28 INFO - PROCESS | 8031 | Values: 3121.1 3151.3 3152.6 3162.6 3191.8 5480.5 5503.4 5527.4 5550.6 5554.4 5543.6 5572.8 5591.1 5597.4 5607.1 5060.6 5060.6 5105.3 5125.3 5149.8 4998.6 5115.2 5154.1 5154.7 5164.9 4971.3 5042.8 5051.2 5058.9 5067.7 5098.3 5119.2 5131.8 5159.6 5164.3 4998.4 5086.3 5127.7 5143.8 5165.5 5448.2 5501.1 5520.0 5526.8 5564.2 5929.7 5941.1 5950.3 6025.2 6031.1 6066.8 6070.7 6081.5 6097.8 6102.3 5399.7 5452.3 5537.3 5560.1 5594.0 6114.2 6128.6 6130.2 6134.7 6149.1 5669.1 5904.6 5912.3 5915.4 5922.9 5791.5 5923.9 5971.5 5972.7 6079.2 5990.1 6018.6 6025.0 6026.3 6032.8 5976.6 6007.9 6020.8 6023.1 6077.3 4496.8 4540.1 4597.1 4652.2 4662.5 4139.1 4146.9 4147.5 4157.1 4178.8 5756.4 5777.6 5795.0 5798.1 5798.1 5810.7 5881.2 5955.5 6003.8 6106.5 5757.5 5765.6 5767.8 5772.9 5781.2 5041.7 5045.8 5057.3 5060.3 5081.6 5899.6 6031.0 6100.1 6240.0 6243.5 6027.6 6066.2 6091.3 6096.0 6100.4 6177.7 6202.5 6226.9 6234.4 6259.3 5733.5 5779.7 5856.7 5982.2 6017.2 5974.5 6026.6 6048.2 6051.8 6088.2 5814.6 5814.9 5877.9 5884.6 5891.1 5618.2 5670.5 5872.6 5886.6 5887.1 5788.0 5791.9 5814.5 5816.6 5894.4 5890.2 5963.2 5964.4 5966.8 5968.9 5502.1 5531.8 5793.9 5806.9 5814.2 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#1] ext.html Cycles:180 Average:64215.44 Median:38828.92 stddev:127842.74 (329.2%) stddev-sans-first:128112.12 03:52:28 INFO - PROCESS | 8031 | Values: 590.1 605.0 637.9 662.7 663.6 35261.6 35908.5 37618.4 37668.0 37687.0 38258.8 48771.3 49575.0 49718.0 52727.7 9147.6 9211.2 9292.2 9292.2 9295.0 8897.6 8961.4 8971.1 8984.9 8988.5 8572.7 8741.2 10991.7 11195.7 11205.9 11184.8 11200.4 11215.4 11240.3 11250.4 8373.3 10884.1 10966.7 10982.7 10995.4 35849.3 36121.8 36250.6 43815.8 44736.6 3861.8 3873.8 3894.3 4037.4 4072.1 33375.7 34125.5 34325.5 34527.3 36096.8 4667.5 4683.0 4718.8 4751.0 4757.6 368049.0 369057.0 369132.0 370023.0 370767.0 62990.7 63543.0 63564.7 63625.7 63641.4 60882.4 62127.7 67128.0 67424.7 68759.0 18512.2 19169.2 19183.9 19200.6 19292.1 14212.6 14322.8 14329.4 14337.9 14412.4 16795.4 17187.0 18208.4 18459.9 18562.7 6591.9 6952.7 6996.2 7012.4 7129.3 989.7 1028.5 1034.4 1051.9 1087.3 33798.3 33843.7 34124.0 34262.3 34421.8 1160.4 1179.3 1199.8 1212.7 1250.8 17884.6 18019.3 18048.6 18051.5 18113.6 542596.0 545282.0 547133.0 547470.0 548397.0 55305.0 56291.7 60600.0 62251.1 62449.1 1387.9 1400.7 1402.0 1439.9 1452.3 33075.5 35463.5 35565.9 35623.6 35731.3 55490.0 55733.7 55860.4 55866.0 56051.4 502812.0 508254.0 509468.0 518859.0 520635.0 29800.3 29803.3 29816.9 30040.7 30158.5 49649.8 50071.5 50132.0 50208.0 50293.5 42562.6 42623.6 42722.6 42985.4 43894.3 41280.4 42098.0 42560.8 43758.3 43764.0 39511.6 40225.0 40875.0 41148.2 41350.4 36020.8 37274.8 37993.4 38804.4 38853.4 29009.3 29305.7 29484.9 29529.9 29535.7 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#2] jquery.html Cycles:180 Average:29346.88 Median:25361.18 stddev:77968.08 (307.4%) stddev-sans-first:78156.48 03:52:28 INFO - PROCESS | 8031 | Values: 387.4 426.2 428.6 436.2 449.5 16020.5 19918.1 19963.3 20846.4 21739.2 19786.5 20336.9 20385.6 20389.1 20622.5 5717.6 5797.5 5849.9 5882.3 5884.4 5711.2 5816.4 5821.6 5824.9 5826.3 5626.7 5834.9 5863.5 5863.8 5864.6 5798.1 5822.1 5862.5 5865.3 5872.2 5138.4 5301.5 5307.2 5308.0 5308.2 24744.5 24972.0 24998.9 25255.4 25467.0 2580.9 2632.4 2652.6 2867.2 2994.3 15041.8 15539.4 15546.6 15765.8 15786.8 1984.3 2023.1 2040.1 2041.5 2084.0 86602.0 90583.0 91261.5 91464.5 91645.5 10682.2 10912.7 11070.4 11267.4 11501.0 16592.7 16652.3 16656.9 16666.9 16709.2 8784.2 8817.4 8973.4 9026.4 9175.3 8599.6 8601.6 8649.7 8775.6 8790.4 7061.3 7076.7 7199.2 7223.1 7284.7 1962.8 2010.4 2014.3 2021.1 2064.6 872.7 1038.9 1042.0 1088.2 1091.0 20958.2 21126.8 21291.4 21352.0 21478.4 1062.2 1071.7 1089.4 1090.0 1124.9 11143.2 12159.3 12160.0 12326.3 12392.2 460891.0 463675.0 469045.0 481426.0 483050.0 87179.0 90955.0 91370.5 92137.5 93791.0 1085.0 1101.0 1102.5 1102.9 1111.9 18528.3 18722.6 19060.2 19069.8 19134.1 42140.2 43211.8 43291.4 43427.8 43562.6 58327.4 58517.0 58709.7 59194.0 61886.4 8129.1 8190.9 8314.4 8418.8 8963.2 9849.6 13069.9 13491.6 13639.5 13874.2 7259.6 11331.2 12165.1 12220.5 12235.9 11282.8 11459.2 11480.5 11781.0 11794.7 12058.5 12172.1 12185.3 12407.4 12503.4 8037.1 8328.4 8406.1 8426.6 8447.7 12127.9 12181.7 12219.6 12373.6 12543.4 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#3] mootools.html Cycles:180 Average:6176.78 Median:4404.17 stddev:3499.37 (79.5%) stddev-sans-first:3490.98 03:52:28 INFO - PROCESS | 8031 | Values: 1426.2 1531.8 1555.5 1718.4 1844.4 8204.0 8778.1 9055.8 9057.9 9289.5 9036.1 9095.5 9100.7 9108.1 9120.2 2108.4 2180.0 2503.2 2531.4 2540.9 2351.4 2409.7 2427.1 2433.3 2436.2 2346.3 2346.6 2353.4 2385.0 2435.6 2333.6 2370.2 2377.1 2379.3 2413.6 2565.1 2576.4 2593.4 2593.9 2595.8 9488.5 9548.9 9582.7 9583.4 9589.4 5519.6 5694.4 5742.0 5752.9 5753.9 3589.5 3590.1 3619.4 3625.1 3686.6 1162.5 1193.1 1201.4 1218.0 1219.5 13208.7 13253.4 13323.8 13369.0 13388.9 4809.7 4815.1 4875.0 4891.5 4994.4 10204.7 10324.7 10332.6 10342.5 10351.7 5518.9 5552.9 5556.6 5620.5 5627.5 4397.6 4566.4 5180.8 5263.0 5275.9 4055.5 4069.9 4163.7 4169.4 4185.5 1230.3 1245.7 1251.4 1259.3 1259.6 990.2 995.0 1029.9 1038.3 1045.2 6050.3 6586.3 6611.1 6728.0 6984.3 1018.0 1025.4 1055.2 1058.1 1074.2 4290.4 4318.5 4410.7 4475.5 4523.5 11236.3 11645.5 11668.9 11673.2 11736.6 10769.5 11083.6 11548.5 11556.7 11599.4 8864.8 9047.1 9055.7 9062.2 9062.7 6540.8 6569.1 6588.1 6592.9 6751.6 10071.3 10808.9 10859.3 10904.9 11018.2 10330.8 10442.1 10566.8 10567.2 10649.6 7950.0 8209.1 8819.9 8873.2 9066.0 9178.4 9335.3 9345.1 9347.6 9359.4 8189.0 8214.1 8322.1 8347.9 8464.9 8078.4 8212.4 8253.0 8271.3 8340.1 7637.8 7654.1 7769.8 7811.9 7847.6 5449.8 5749.8 5837.3 5877.9 5968.9 5323.5 5337.0 5420.5 5463.0 5507.4 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#4] prototype.html Cycles:180 Average:4701.39 Median:5218.56 stddev:1366.93 (26.2%) stddev-sans-first:1331.24 03:52:28 INFO - PROCESS | 8031 | Values: 353.3 354.3 359.6 363.6 364.3 5461.9 5555.3 5558.1 5561.5 5566.6 5221.0 5244.8 5347.7 5427.2 5509.2 4276.4 4290.2 4295.5 4299.9 4308.8 4255.6 4280.1 4283.7 4311.8 4317.7 4096.0 4237.2 4260.8 4264.2 4271.3 4206.1 4225.5 4246.9 4258.6 4264.1 3755.0 3755.1 3768.9 3773.6 3779.9 5231.8 5352.0 5366.3 5371.7 5414.0 4896.4 4903.5 4908.8 4921.6 4928.9 5720.5 5723.9 5757.7 5758.5 5766.5 4017.7 4082.2 4099.5 4134.8 4135.6 5945.8 5959.9 5968.7 5983.7 5986.6 4225.6 4229.7 4237.9 4242.0 4244.8 4065.7 4253.9 4273.9 4283.6 4286.7 4878.7 4879.8 4885.0 4890.9 4897.2 5788.5 5798.2 5808.5 5809.6 5813.0 1453.4 1464.2 1469.0 1473.5 1486.9 914.0 939.6 946.2 948.4 952.3 4892.8 4947.9 4954.0 4972.5 4994.8 5194.5 5196.5 5198.3 5212.6 5217.2 4709.5 4949.3 4970.3 4977.7 5010.0 2789.7 2791.4 2804.2 2811.3 2812.0 5341.8 5341.9 5373.6 5391.7 5400.9 4953.4 5265.3 5298.6 5336.8 5364.2 5312.7 5320.6 5320.9 5347.6 5352.9 5160.5 5188.5 5191.7 5203.5 5219.9 5132.5 5490.8 5827.5 5919.6 5924.9 6073.7 6129.8 6164.6 6172.8 6187.5 4050.7 4233.8 4240.7 4257.3 4257.8 5876.4 5911.5 5912.2 5923.3 5923.6 5777.6 5785.2 5792.3 5798.6 5807.4 5633.7 5682.3 5698.6 5731.7 5792.7 5726.1 5731.4 5746.9 5751.4 5757.3 5576.3 5721.1 5756.0 5800.0 5808.9 5602.4 5614.4 5646.9 5647.8 5651.2 03:52:28 INFO - PROCESS | 8031 | 03:52:28 INFO - PROCESS | 8031 | [#5] yui.html Cycles:180 Average:22386.48 Median:4715.45 stddev:32388.83 (686.9%) stddev-sans-first:32439.14 03:52:28 INFO - PROCESS | 8031 | Values: 802.9 825.7 836.8 841.2 897.5 16157.8 17459.2 17473.2 17499.4 17519.1 12248.6 16083.6 16225.3 16399.7 16403.3 721.4 861.8 875.6 878.3 881.2 872.4 874.3 875.7 875.9 876.0 813.7 814.6 814.9 815.0 815.1 748.2 774.5 899.5 925.6 931.3 684.9 685.5 685.8 686.2 686.3 16672.3 16677.4 16698.2 16701.2 16715.2 15846.6 15863.8 15877.2 15916.8 15983.7 14546.5 14556.6 14606.3 14661.3 14710.9 4621.9 4655.7 4661.7 4695.1 4792.0 83691.6 84488.0 84872.6 85435.6 85674.0 12213.2 12216.6 12305.3 12359.1 12373.3 23899.6 24114.5 24134.4 24139.3 24165.0 8736.1 8776.6 8813.8 9043.7 9100.2 5067.3 5076.2 5156.5 5161.7 5202.8 3712.9 3842.9 3846.7 3847.5 3858.8 646.8 647.8 651.1 664.2 666.5 713.2 744.3 751.9 766.5 789.2 9921.6 10284.9 10562.9 10592.5 10890.5 633.8 638.0 699.2 705.7 792.4 4735.8 4979.9 5000.1 5030.3 5045.7 97735.0 129702.0 130550.0 131603.0 133844.0 64368.4 108749.5 109353.5 113516.4 116486.4 65424.7 91219.5 91965.0 93266.5 94491.6 9206.0 9247.2 9300.8 9515.5 9625.8 57186.1 57571.7 58535.4 58565.7 59884.0 76271.0 84597.0 84979.0 85249.0 86726.0 12508.4 12701.1 13102.3 13175.6 13502.6 13331.1 13459.3 13563.9 13674.9 14509.6 12401.9 12738.9 12782.9 12907.7 13319.7 13018.2 13169.9 13229.0 14126.5 14309.6 12772.4 14055.4 14255.4 14748.2 16080.1 11923.7 12624.4 13375.1 13488.5 13748.8 13170.5 13497.8 13652.4 13677.5 13838.2 03:52:28 INFO - PROCESS | 8031 | -------- Summary: end -------- 03:52:28 INFO - PROCESS | 8031 | 03:52:29 INFO - TEST-INFO | 8031: exit 0 03:52:29 INFO - TEST-OK | dromaeo_css | took 1113404ms 03:52:29 INFO - TEST-START | kraken 03:52:29 INFO - operating with platform_type : linux_ 03:52:29 INFO - Initialising browser for kraken test... 03:52:29 INFO - TEST-INFO | started process 8355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDK8H61/profile http://localhost:33569/getInfo.html) 03:52:33 INFO - PROCESS | 8355 | __metrics Screen width/height:1600/1200 03:52:33 INFO - PROCESS | 8355 | colorDepth:24 03:52:33 INFO - PROCESS | 8355 | Browser inner width/height: 1024/697 03:52:33 INFO - PROCESS | 8355 | __metrics 03:52:34 INFO - PROCESS | 8355 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:34 INFO - PROCESS | 8355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:34 INFO - PROCESS | 8355 | console.error: PushService: 03:52:34 INFO - PROCESS | 8355 | stateChangeProcessEnqueue: Error transitioning state 03:52:34 INFO - PROCESS | 8355 | UnknownError 03:52:34 INFO - TEST-INFO | 8355: exit 0 03:52:34 INFO - Browser initialized. 03:52:34 INFO - Running cycle 1/1 for kraken test... 03:52:34 INFO - TEST-INFO | started process 8451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDK8H61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:46 INFO - PROCESS | 8451 | RSS: Main: 144560128 03:52:46 INFO - PROCESS | 8451 | 03:52:49 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33569/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:50 INFO - PROCESS | 8451 | RSS: Main: 185516032 03:52:50 INFO - PROCESS | 8451 | 03:52:52 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33569/tests/kraken/driver.html?testName=audio-dft) 03:52:53 INFO - PROCESS | 8451 | RSS: Main: 175677440 03:52:53 INFO - PROCESS | 8451 | 03:52:56 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33569/tests/kraken/driver.html?testName=audio-fft) 03:52:56 INFO - PROCESS | 8451 | RSS: Main: 266846208 03:52:56 INFO - PROCESS | 8451 | 03:52:58 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33569/tests/kraken/driver.html?testName=audio-oscillator) 03:52:59 INFO - PROCESS | 8451 | RSS: Main: 173740032 03:52:59 INFO - PROCESS | 8451 | 03:53:01 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:01 INFO - PROCESS | 8451 | RSS: Main: 175456256 03:53:01 INFO - PROCESS | 8451 | 03:53:04 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33569/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:05 INFO - PROCESS | 8451 | RSS: Main: 212127744 03:53:05 INFO - PROCESS | 8451 | 03:53:08 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33569/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:09 INFO - PROCESS | 8451 | RSS: Main: 210423808 03:53:09 INFO - PROCESS | 8451 | 03:53:12 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33569/tests/kraken/driver.html?testName=json-parse-financial) 03:53:12 INFO - PROCESS | 8451 | RSS: Main: 209113088 03:53:12 INFO - PROCESS | 8451 | 03:53:14 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:14 INFO - PROCESS | 8451 | RSS: Main: 171884544 03:53:14 INFO - PROCESS | 8451 | 03:53:16 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:17 INFO - PROCESS | 8451 | RSS: Main: 179298304 03:53:17 INFO - PROCESS | 8451 | 03:53:19 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:19 INFO - PROCESS | 8451 | RSS: Main: 188866560 03:53:19 INFO - PROCESS | 8451 | 03:53:22 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:23 INFO - PROCESS | 8451 | RSS: Main: 192151552 03:53:23 INFO - PROCESS | 8451 | 03:53:25 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:26 INFO - PROCESS | 8451 | RSS: Main: 193769472 03:53:26 INFO - PROCESS | 8451 | 03:53:27 INFO - PROCESS | 8451 | Cycle 1(1): loaded http://localhost:33569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33569/tests/kraken/driver.html?testName=ai-astar) 03:53:28 INFO - PROCESS | 8451 | RSS: Main: 245456896 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | __start_tp_report 03:53:28 INFO - PROCESS | 8451 | _x_x_mozilla_page_load 03:53:28 INFO - PROCESS | 8451 | _x_x_mozilla_page_load_details 03:53:28 INFO - PROCESS | 8451 | |i|pagename|runs| 03:53:28 INFO - PROCESS | 8451 | |0;ai-astar;108;110;111;110;111;110;109;110;110;111 03:53:28 INFO - PROCESS | 8451 | |1;audio-beat-detection;143;117;117;148;122;118;116;115;151;122 03:53:28 INFO - PROCESS | 8451 | |2;audio-dft;160;160;160;158;168;160;161;161;159;161 03:53:28 INFO - PROCESS | 8451 | |3;audio-fft;76;74;75;105;76;76;75;76;104;75 03:53:28 INFO - PROCESS | 8451 | |4;audio-oscillator;81;81;114;82;82;81;113;81;81;108 03:53:28 INFO - PROCESS | 8451 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;116;118 03:53:28 INFO - PROCESS | 8451 | |6;imaging-darkroom;146;146;145;146;146;146;146;145;147;146 03:53:28 INFO - PROCESS | 8451 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 03:53:28 INFO - PROCESS | 8451 | |8;json-parse-financial;50;49;47;50;53;51;49;49;49;49 03:53:28 INFO - PROCESS | 8451 | |9;json-stringify-tinderbox;58;59;59;60;58;58;59;59;60;58 03:53:28 INFO - PROCESS | 8451 | |10;stanford-crypto-aes;74;73;74;75;74;74;74;74;81;73 03:53:28 INFO - PROCESS | 8451 | |11;stanford-crypto-ccm;128;121;131;126;119;118;120;126;203;136 03:53:28 INFO - PROCESS | 8451 | |12;stanford-crypto-pbkdf2;157;161;161;163;160;156;158;155;156;162 03:53:28 INFO - PROCESS | 8451 | |13;stanford-crypto-sha256-iterative;63;64;65;66;63;64;62;63;63;62 03:53:28 INFO - PROCESS | 8451 | __end_tp_report 03:53:28 INFO - PROCESS | 8451 | __start_cc_report 03:53:28 INFO - PROCESS | 8451 | _x_x_mozilla_cycle_collect,1658 03:53:28 INFO - PROCESS | 8451 | __end_cc_report 03:53:28 INFO - PROCESS | 8451 | __startTimestamp1476269608183__endTimestamp 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | ------- Summary: start ------- 03:53:28 INFO - PROCESS | 8451 | Number of tests: 14 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:0.94 (0.9%) stddev-sans-first:0.67 03:53:28 INFO - PROCESS | 8451 | Values: 108.0 110.0 111.0 110.0 111.0 110.0 109.0 110.0 110.0 111.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:122.00 stddev:14.41 (11.8%) stddev-sans-first:14.06 03:53:28 INFO - PROCESS | 8451 | Values: 143.0 117.0 117.0 148.0 122.0 118.0 116.0 115.0 151.0 122.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#2] audio-dft Cycles:10 Average:160.80 Median:160.50 stddev:2.70 (1.7%) stddev-sans-first:2.85 03:53:28 INFO - PROCESS | 8451 | Values: 160.0 160.0 160.0 158.0 168.0 160.0 161.0 161.0 159.0 161.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.30 (16.3%) stddev-sans-first:12.90 03:53:28 INFO - PROCESS | 8451 | Values: 76.0 74.0 75.0 105.0 76.0 76.0 75.0 76.0 104.0 75.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:14.76 (18.2%) stddev-sans-first:15.26 03:53:28 INFO - PROCESS | 8451 | Values: 81.0 81.0 114.0 82.0 82.0 81.0 113.0 81.0 81.0 108.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:53:28 INFO - PROCESS | 8451 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 118.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:53:28 INFO - PROCESS | 8451 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:53:28 INFO - PROCESS | 8451 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:49.50 stddev:1.58 (3.2%) stddev-sans-first:1.67 03:53:28 INFO - PROCESS | 8451 | Values: 50.0 49.0 47.0 50.0 53.0 51.0 49.0 49.0 49.0 49.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 03:53:28 INFO - PROCESS | 8451 | Values: 58.0 59.0 59.0 60.0 58.0 58.0 59.0 59.0 60.0 58.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.32 (3.1%) stddev-sans-first:2.45 03:53:28 INFO - PROCESS | 8451 | Values: 74.0 73.0 74.0 75.0 74.0 74.0 74.0 74.0 81.0 73.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:127.00 stddev:25.32 (19.9%) stddev-sans-first:26.80 03:53:28 INFO - PROCESS | 8451 | Values: 128.0 121.0 131.0 126.0 119.0 118.0 120.0 126.0 203.0 136.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:160.50 stddev:2.85 (1.8%) stddev-sans-first:2.93 03:53:28 INFO - PROCESS | 8451 | Values: 157.0 161.0 161.0 163.0 160.0 156.0 158.0 155.0 156.0 162.0 03:53:28 INFO - PROCESS | 8451 | 03:53:28 INFO - PROCESS | 8451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.27 (2.0%) stddev-sans-first:1.33 03:53:28 INFO - PROCESS | 8451 | Values: 63.0 64.0 65.0 66.0 63.0 64.0 62.0 63.0 63.0 62.0 03:53:28 INFO - PROCESS | 8451 | -------- Summary: end -------- 03:53:28 INFO - PROCESS | 8451 | 03:53:29 INFO - TEST-INFO | 8451: exit 0 03:53:29 INFO - TEST-OK | kraken | took 59949ms 03:53:29 INFO - SUITE-END | took 1173s 03:53:29 INFO - Completed test suite (00:19:33) 03:53:29 INFO - javascript benchmark 03:53:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.1416860363406, 3151.2752067024576, 3152.55864179015, 3162.636296825866, 3191.776575639706, 5480.5341545968595, 5503.449655034495, 5527.419620939793, 5550.555955523559, 5554.444555544444, 5543.6119471637, 5572.832815015546, 5591.077472217079, 5597.412271711472, 5607.130894711327, 5060.595152387809, 5060.645754797166, 5105.310783044279, 5125.333706618135, 5149.794008239666, 4998.5501304882555, 5115.181570948649, 5154.098032844237, 5154.74226288686, 5164.922526162091, 4971.328870602477, 5042.798288068473, 5051.191809310511, 5058.873528161788, 5067.670601410915, 5098.337216161894, 5119.1809310510325, 5131.7690703918415, 5159.5614372778355, 5164.2770012198325, 4998.400191976986, 5086.3133476980875, 5127.743612819344, 5143.7685304161405, 5165.483451654842, 5448.182772584105, 5501.14732216503, 5520.0, 5526.834194974157, 5564.221009058735, 5929.733162007677, 5941.079132734433, 5950.345461999176, 6025.246844144482, 6031.1254868044325, 6066.817995460143, 6070.726817293188, 6081.452669259744, 6097.7865774697675, 6102.3287438382185, 5399.7030163341, 5452.318460192476, 5537.307836520435, 5560.138178582326, 5594.0, 6114.205153330127, 6128.571000030044, 6130.233720784902, 6134.693265336805, 6149.0776383542825, 5669.121286200645, 5904.645721256738, 5912.260967379078, 5915.37888521699, 5922.881542369215, 5791.536677065825, 5923.881522369528, 5971.4924231439945, 5972.701364931736, 6079.240094988127, 5990.131430942576, 6018.608790428696, 6024.969875150684, 6026.337102918676, 6032.788852390233, 5976.61152025117, 6007.879842403215, 6020.759169633166, 6023.066424704178, 6077.270727512727, 4496.752678602708, 4540.137373899015, 4597.057603191338, 4652.185867473178, 4662.463816661128, 4139.089400331922, 4146.937795933063, 4147.502299724052, 4157.147784704129, 4178.811953462041, 5756.395578464201, 5777.566682498746, 5795.0, 5798.101294299306, 5798.1302804579655, 5810.709464526757, 5881.235439392852, 5955.493783028404, 6003.759849605967, 6106.4809491192855, 5757.481826635623, 5765.596408251382, 5767.798127065533, 5772.855678608068, 5781.248437703071, 5041.672291301127, 5045.772940217699, 5057.342545469065, 5060.2662613920775, 5081.644284900021, 5899.616524925866, 6030.999999999913, 6100.145979562776, 6240.032794916704, 6243.469305109116, 6027.608205466806, 6066.181065556093, 6091.329953705177, 6096.0, 6100.389961003864, 6177.722002509988, 6202.534809889186, 6226.937730622817, 6234.407731265523, 6259.311475737574, 5733.483986441073, 5779.739911703899, 5856.707164641836, 5982.192404025401, 6017.18767966319, 5974.522038237017, 6026.638401695737, 6048.183495228264, 6051.818445446644, 6088.238970128734, 5814.622049566765, 5814.912776308274, 5877.882442351214, 5884.558658100746, 5891.11633254998, 5618.157276408571, 5670.5180059695385, 5872.647641141545, 5886.58793884424, 5887.116932460165, 5787.971060144672, 5791.884162316815, 5814.505767009682, 5816.621919575214, 5894.410558944071, 5890.204822348928, 5963.194968679173, 5964.373740757332, 5966.820995370146, 5968.940310597012, 5502.147167189092, 5531.834044978657, 5793.884122317446, 5806.9419305806405, 5814.215080964185], "value": 5517.527122670679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.108935507384, 604.9806076760657, 637.8756142552202, 662.6786008785741, 663.5952069237767, 35261.647383526186, 35908.46137307942, 37618.43572346417, 37668.0, 37687.0, 38258.80870595643, 48771.26843097356, 49575.0, 49718.0, 52727.73636131814, 9147.634094636207, 9211.170994610484, 9292.163705266525, 9292.210162136227, 9294.953525232364, 8897.555122243893, 8961.417507862001, 8971.102889711043, 8984.8652270216, 8988.460692358447, 8572.657093716243, 8741.169588889044, 10991.725206869813, 11195.66413007607, 11205.943970280137, 11184.825593312707, 11200.439978001148, 11215.439228038565, 11240.269382490113, 11250.3812290324, 8373.288270497014, 10884.129269658408, 10966.670999870017, 10982.670519884416, 10995.395253261067, 35849.28301433957, 36121.81939090314, 36250.63749362499, 43815.78092109551, 44736.55263447356, 3861.8455261789495, 3873.8140748910646, 3894.2990261752875, 4037.4145748866545, 4072.124493233969, 33375.66624333774, 34125.48811767826, 34325.485117723256, 34527.30945381078, 36096.81951590251, 4667.4632417272105, 4682.976585117052, 4718.834840780591, 4751.0, 4757.571818536314, 368049.0, 369057.0, 369132.0, 370023.0, 370767.0, 62990.68504657447, 63543.0, 63564.68217658882, 63625.681871591274, 63641.36358636447, 60882.39117608856, 62127.689361552904, 67128.0, 67424.6628766853, 68759.0, 18512.16695248717, 19169.233230670896, 19183.904080479788, 19200.61598768017, 19292.1318540666, 14212.644683882985, 14322.785158222636, 14329.35517901697, 14337.928310358382, 14412.423503059761, 16795.41216057432, 17187.0, 18208.36270730518, 18459.907700461412, 18562.721559176352, 6591.934080659228, 6952.652367381712, 6996.230414654384, 7012.403945664573, 7129.251428600026, 989.6684610655367, 1028.5320179318542, 1034.3948789957808, 1051.9000694933968, 1087.255230167338, 33798.324033519195, 33843.66156338454, 34124.0, 34262.31475370529, 34421.82789086038, 1160.4023927677254, 1179.3159967218992, 1199.7960346741074, 1212.7271363943041, 1250.7936190528642, 17884.642307153783, 18019.27922883096, 18048.639027219644, 18051.54871128206, 18113.637727245383, 542596.0, 545282.0, 547133.0, 547470.0, 548397.0, 55305.0, 56291.71854140703, 60600.0, 62251.06623400562, 62449.063264051074, 1387.8889688824668, 1400.7338605665095, 1401.978970315446, 1439.9064060836013, 1452.3319273134266, 33075.50386744153, 35463.46804797982, 35565.86141068022, 35623.64376356307, 35731.285374291845, 55490.0, 55733.721331393084, 55860.44139558553, 55866.0, 56051.43948560462, 502812.0, 508254.0, 509468.0, 518859.0, 520635.0, 29800.254993625334, 29803.254918627208, 29816.850915745283, 30040.699593003792, 30158.547621785252, 49649.75175124246, 50071.499285006685, 50132.0, 50208.0, 50293.49706502888, 42562.5743742571, 42623.57376426196, 42722.5727742731, 42985.355219672354, 43894.34158487561, 41280.38079428751, 42098.0, 42560.78719606382, 43758.34362484629, 43764.0, 39511.60488395079, 40225.0, 40875.0, 41148.1770364597, 41350.37974430326, 36020.81989590035, 37274.813625931696, 37993.4300985491, 38804.41793373045, 38853.41719874261, 29009.274768130967, 29305.706942930297, 29484.852575736983, 29529.85235073811, 29535.704642953297], "value": 21268.102761720533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.36472185615577, 426.1710972159151, 428.5679967328898, 436.2278766583148, 449.5032988547655, 16020.519384418458, 19918.103685334176, 19963.30128445503, 20846.374608761722, 21739.23912663057, 19786.505337366572, 20336.898315508402, 20385.59228815423, 20389.08249128789, 20622.48443788906, 5717.599768016241, 5797.536197104232, 5849.912251316212, 5882.323532793719, 5884.382139875315, 5711.200431939532, 5816.4474374934525, 5821.56338274629, 5824.86415149044, 5826.300843898717, 5626.746796394172, 5834.883302333972, 5863.501602363783, 5863.79476718315, 5864.648121112747, 5798.092068114945, 5822.0684690449325, 5862.472377486004, 5865.266841644773, 5872.207252020965, 5138.3577052868395, 5301.522862942315, 5307.150855863082, 5307.9734601326745, 5308.177232528964, 24744.50510989788, 24972.0, 24998.875005624854, 25255.36861578475, 25467.0, 2580.8580528070947, 2632.3682316244153, 2652.575587905945, 2867.1828528869382, 2994.3262765877503, 15041.774373384407, 15539.378424862993, 15546.61133471661, 15765.763513547307, 15786.763198552031, 1984.2559040359865, 2023.1401654296865, 2040.1271354787386, 2041.469218003315, 2083.9889506626178, 86602.0, 90583.0, 91261.54369228178, 91464.54267728618, 91645.54177229138, 10682.1988350874, 10912.67261982126, 11070.391128487849, 11267.38029408374, 11501.0, 16592.668146637, 16652.250648720837, 16656.916715416344, 16666.916665416837, 16709.248083836013, 8784.165504277084, 8817.426867253607, 8973.37186396946, 9026.368154229142, 9175.265978721687, 8599.61301741423, 8601.612927418157, 8649.654013839501, 8775.561221938877, 8790.42862213954, 7061.293870613001, 7076.681549330293, 7199.172095209118, 7223.061002069802, 7284.745033923788, 1962.8037196280259, 2010.3667344786638, 2014.325201057662, 2021.1208124465904, 2064.576761763835, 872.6683860133109, 1038.864947556828, 1041.9739506512246, 1088.172988528708, 1090.9509072091776, 20958.16167353319, 21126.788732112484, 21291.36125916225, 21352.0, 21478.355649330544, 1062.2033474893828, 1071.6677829872765, 1089.4334945828125, 1090.0026475774578, 1124.8650161980615, 11143.219974601861, 12159.331236781885, 12160.0, 12326.32205228703, 12392.194507356993, 460891.0, 463675.0, 469045.0, 481426.0, 483050.0, 87179.0, 90955.0, 91370.54314728516, 92137.53931230301, 93791.0, 1084.9783004340027, 1101.0475938313461, 1102.47081400928, 1102.9338239705644, 1111.8610173728284, 18528.258869645604, 18722.625547489246, 19060.23759049678, 19069.809301906804, 19134.138963746387, 42140.157196855274, 43211.783941080095, 43291.35062973995, 43427.78286108549, 43562.56437435712, 58327.4167258322, 58517.0, 58709.70645146747, 59194.0, 61886.381136188065, 8129.105798362294, 8190.918090819254, 8314.41799074059, 8418.831623367376, 8963.238124759468, 9849.556769945226, 13069.934650326688, 13491.595252142451, 13639.454421823017, 13874.236916969663, 7259.6370181491775, 11331.150163737588, 12165.148439609497, 12220.450079746255, 12235.87764122383, 11282.774344513227, 11459.19785614999, 11480.540778368771, 11781.0, 11794.705132371759, 12058.457369418573, 12172.14794964344, 12185.268883866996, 12407.441665125272, 12503.374831258583, 8037.075736290401, 8328.375371847014, 8406.117357677356, 8426.5786710663, 8447.66209351619, 12127.878721212675, 12181.69545761363, 12219.572314968933, 12373.62879113628, 12543.435545400296], "value": 9795.034819778792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.2227086238, 1531.77023446483, 1555.5022392834294, 1718.3899715600962, 1844.419008012476, 8204.0, 8778.078301778309, 9055.818883622323, 9057.864132038025, 9289.535523223845, 9036.141566551183, 9095.45427274364, 9100.726978190665, 9108.089191080906, 9120.224780893615, 2108.441263065289, 2179.967300490494, 2503.236512863576, 2531.354504601324, 2540.898364065444, 2351.3886389538757, 2409.734929157791, 2427.0898413095088, 2433.3308340206495, 2436.2325867351815, 2346.296111166652, 2346.6480027995767, 2353.4351755578623, 2384.9761502384927, 2435.610302351624, 2333.6266197408504, 2370.1941339944415, 2377.108584280895, 2379.262428647125, 2413.553492603874, 2565.1278565287707, 2576.381668399589, 2593.3775893785355, 2593.9092131775296, 2595.779358754508, 9488.478133702643, 9548.856767148498, 9582.664606738801, 9583.424994500352, 9589.376690515093, 5519.641223320512, 5694.402087780765, 5742.0, 5752.913706294409, 5753.856153596152, 3589.4795254688183, 3590.138366791977, 3619.384704600198, 3625.093726568358, 3686.64976827201, 1162.5466068233395, 1193.1409385242698, 1201.411308458849, 1217.9634610961684, 1219.5182902753363, 13208.735825283537, 13253.403596838165, 13323.800142997863, 13369.0, 13388.93305533466, 4809.663323567317, 4815.061063092733, 4874.951250487521, 4891.510848915151, 4994.425641051325, 10204.744881378025, 10324.741881452874, 10332.638357657446, 10342.534585943651, 10351.741206469747, 5518.862028449241, 5552.86117847049, 5556.638818476867, 5620.4660557247, 5627.493525582717, 4397.648188144941, 4566.383538222364, 5180.766865491062, 5262.97368513155, 5275.920861187085, 4055.533613634411, 4069.877903662895, 4163.7293575917465, 4169.395437661522, 4185.539590645027, 1230.317173968456, 1245.6636708088765, 1251.386820457969, 1259.250745806244, 1259.622113366005, 990.1633120013721, 994.9900500994897, 1029.8712660917386, 1038.2576457832536, 1045.1586472889396, 6050.334463209044, 6586.341365863471, 6611.074449577063, 6727.966360168168, 6984.301569843076, 1017.9694609161737, 1025.415513157508, 1055.2402270365324, 1058.1481907064733, 1074.2426589254712, 4290.399344091829, 4318.460192475941, 4410.69125161242, 4475.462944446687, 4523.547645235451, 11236.325820450798, 11645.475953582109, 11668.94165529167, 11673.241239319417, 11736.647900562997, 10769.461526923778, 11083.556657733601, 11548.480318385693, 11556.653300401002, 11599.362035088152, 8864.778380540409, 9047.140521650434, 9055.68305109318, 9062.184403403593, 9062.728118156467, 6540.771073012422, 6569.146011018537, 6588.110605068446, 6592.901106483502, 6751.56114852533, 10071.295009349275, 10808.891911081104, 10859.294145880493, 10904.890951090387, 11018.173636977099, 10330.845037324296, 10442.060214580724, 10566.8414973777, 10567.207459440418, 10649.627263045757, 7949.960250198712, 8209.13804050566, 8819.911800882166, 8873.157050080232, 9065.95467022687, 9178.357514974155, 9335.346525743133, 9345.112214339626, 9347.579358929, 9359.391639543408, 8188.959055204924, 8214.13751556078, 8322.08457069734, 8347.916520834713, 8464.915350846413, 8078.434509584273, 8212.384071194803, 8253.009638843378, 8271.33829293643, 8340.082590914873, 7637.809054773675, 7654.119776225805, 7769.844603107793, 7811.921880781119, 7847.607619618882, 5449.836504904859, 5749.770009199585, 5837.29952405714, 5877.94122058774, 5968.910466342922, 5323.547498462674, 5337.0, 5420.4850539198715, 5463.0, 5507.449255074621], "value": 4931.222538240274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.28812442927506, 354.30732917146975, 359.6493418916557, 363.5691705329185, 364.26236870337544, 5461.890762184754, 5555.30558680165, 5558.110702287635, 5561.499465048145, 5566.582506312027, 5220.973895130529, 5244.816431424901, 5347.7058761768085, 5427.158790387496, 5509.173623956409, 4276.434139516296, 4290.1848648756795, 4295.518046274046, 4299.914001719963, 4308.849190278341, 4255.553166917475, 4280.101178752466, 4283.657307415399, 4311.805968731414, 4317.69776115672, 4095.9724936156645, 4237.152569486099, 4260.786960651971, 4264.189803937242, 4271.337942618899, 4206.095689426757, 4225.492940847118, 4246.897785596118, 4258.6380157686635, 4264.104538047014, 3754.9624503754885, 3755.117547376364, 3768.8869333920024, 3773.603771603997, 3779.90215430436, 5231.822839861039, 5352.0, 5366.2755528004, 5371.731413429313, 5414.0, 4896.387951506062, 4903.4606193318705, 4908.828191013297, 4921.606271498272, 4928.876778080541, 5720.485156335908, 5723.914141287884, 5757.740901659436, 5758.452946970031, 5766.452187042224, 4017.678585713136, 4082.2447847148073, 4099.528554216274, 4134.751914885086, 4135.58644135584, 5945.762169513214, 5959.910601341026, 5968.67172305523, 5983.670898100603, 5986.610870293461, 4225.556316586775, 4229.661627069827, 4237.936430953539, 4241.957580424218, 4244.830206791756, 4065.715399921977, 4253.8723838284905, 4273.87178384649, 4283.635890949242, 4286.657067434598, 4878.707277563358, 4879.780409881564, 4884.95115048852, 4890.926636100461, 4897.216445368796, 5788.450097240755, 5798.246227990334, 5808.477237048602, 5809.593328466966, 5812.970935145382, 1453.4258967707697, 1464.2459133546233, 1469.0, 1473.5432016075051, 1486.8884833637521, 913.9725808225763, 939.6335429182624, 946.1626460582297, 948.3835506920419, 952.2667545989549, 4892.755362231874, 4947.876303092451, 4954.0, 4972.5276098770555, 4994.825181118644, 5194.545527252375, 5196.532312091855, 5198.2722418861385, 5212.635115541876, 5217.217417387422, 4709.529047095331, 4949.257611358325, 4970.254461830682, 4977.65156439053, 5010.0, 2789.693133755285, 2791.3719413131885, 2804.214819850445, 2811.2971757060736, 2812.0, 5341.839744807662, 5341.946580534222, 5373.596980226499, 5391.703456309862, 5400.945990540123, 4953.405591328991, 5265.289185959847, 5298.576113910955, 5336.786528538815, 5364.168553874156, 5312.654677446031, 5320.627556071116, 5320.866978325573, 5347.598930080259, 5352.892942141136, 5160.48395160481, 5188.481151884781, 5191.714455704972, 5203.464977831624, 5219.895602088013, 5132.538071573576, 5490.80782172638, 5827.475527202572, 5919.644821310735, 5924.940750592439, 6073.726682299219, 6129.754809807558, 6164.599301045418, 6172.814815555541, 6187.535934804818, 4050.696197785237, 4233.80947857341, 4240.724352917051, 4257.27626303523, 4257.808398622132, 5876.44173803488, 5911.517162791723, 5912.201852749996, 5923.318818335774, 5923.555733319932, 5777.566682498746, 5785.247917770663, 5792.333881603669, 5798.594098413239, 5807.448292412214, 5633.718314084197, 5682.289713785777, 5698.552375812574, 5731.656100633975, 5792.652440853562, 5726.0838265877255, 5731.369549349652, 5746.856328591652, 5751.396103409249, 5757.337906140848, 5576.330840299028, 5721.141828725725, 5756.021476348947, 5800.0, 5808.854778630568, 5602.411746766531, 5614.438556144516, 5646.85882852932, 5647.830565083054, 5651.15232715096], "value": 4272.117448092737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.9036515618124, 825.7440193540001, 836.8159005018902, 841.1546395872148, 897.5198268926124, 16157.838421615781, 17459.214335354907, 17473.213705383256, 17499.38752143675, 17519.12404379781, 12248.571300004502, 16083.597910052255, 16225.26986285617, 16399.67200655986, 16403.343866245337, 721.422861710632, 861.7845538615346, 875.5709702245917, 878.3412440669498, 881.1628952495123, 872.4198408058634, 874.33113668044, 875.6803766625168, 875.9430637008605, 875.9605817738185, 813.7233340664174, 814.5886327404652, 814.861473549498, 814.9755507334789, 815.1481701621819, 748.1657951384194, 774.4617490843866, 899.4917871402702, 925.6066171876926, 931.2503434735036, 684.9383555480031, 685.4961603221628, 685.8045457044768, 686.2417029182731, 686.306830101601, 16672.33310667572, 16677.416290429897, 16698.165091745363, 16701.164941752864, 16715.164241787985, 15846.603834904105, 15863.841361586467, 15877.206139693084, 15916.76124858128, 15983.680326393524, 14546.4908728194, 14556.563303100818, 14606.269686515632, 14661.266936653125, 14710.926445367704, 4621.907561848744, 4655.7439340836245, 4661.743604101773, 4695.107929493385, 4792.041591681643, 83691.5815420925, 84487.99999999939, 84872.57563712142, 85435.5728221361, 85674.0, 12213.206141600767, 12216.633500994983, 12305.323207223688, 12359.134860559854, 12373.256421094437, 23899.641505377433, 24114.51770964571, 24134.39664008414, 24139.275821725376, 24165.0, 8736.12638736134, 8776.648934042567, 8813.823723525493, 9043.728688139367, 9100.226480749077, 5067.341245638044, 5076.238564215398, 5156.535911767959, 5161.73537483319, 5202.768063099993, 3712.888613341604, 3842.9231415371537, 3846.673032792188, 3847.461355410245, 3858.8456461741216, 646.8318237258346, 647.8218489915216, 651.0754728285846, 664.1797380235405, 666.5367569539221, 713.2475238623302, 744.3449764207571, 751.9097708275042, 766.5170942306423, 789.1831953927772, 9921.553530091163, 10284.897151028394, 10562.894371056345, 10592.470376481298, 10890.509927053301, 633.8193614819754, 638.042935596605, 699.192432740186, 705.7000774670745, 792.397777688949, 4735.786889589976, 4979.925301120486, 5000.099982003201, 5030.270610761419, 5045.672031317952, 97735.0, 129702.0, 130550.0, 131603.02595461076, 133844.0, 64368.35631643717, 108749.45625271981, 109353.45323273492, 113516.43241783738, 116486.41756791162, 65424.67287663531, 91219.54390228007, 91965.0, 93266.53366733123, 94491.58262626066, 9205.953970230106, 9247.167754902091, 9300.837395325585, 9515.476648784106, 9625.759356016155, 57186.14220786608, 57571.71214143903, 58535.4146458547, 58565.707171465576, 59884.0, 76271.0, 84597.0, 84979.0, 85249.0, 86726.0, 12508.374581271082, 12701.110922235355, 13102.279374634487, 13175.60473185806, 13502.594922152352, 13331.133476324008, 13459.327033648475, 13563.86436135626, 13674.93162534181, 14509.637259068608, 12401.875981240071, 12738.936305318413, 12782.872171278541, 12907.741845162856, 13319.66700832487, 13018.218906865619, 13169.868301317247, 13229.0, 14126.50557230492, 14309.64225894361, 12772.42524086437, 14055.437782488585, 14255.429782808571, 14748.188849612945, 16080.115593641995, 11923.701907452036, 12624.431900564681, 13375.130616509896, 13488.5279015234, 13748.793768093687, 13170.539031133865, 13497.797533036815, 13652.385642646303, 13677.521286755315, 13838.16970981704], "value": 8074.884441449137, "unit": "score"}], "name": "dromaeo_css", "value": 7618.621116269298, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 117.0, 148.0, 122.0, 118.0, 116.0, 115.0, 151.0, 122.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 158.0, 168.0, 160.0, 161.0, 161.0, 159.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 105.0, 76.0, 76.0, 75.0, 76.0, 104.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 82.0, 82.0, 81.0, 113.0, 81.0, 81.0, 108.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 47.0, 50.0, 53.0, 51.0, 49.0, 49.0, 49.0, 49.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 58.0, 58.0, 59.0, 59.0, 60.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 75.0, 74.0, 74.0, 74.0, 74.0, 81.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 131.0, 126.0, 119.0, 118.0, 120.0, 126.0, 203.0, 136.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 161.0, 163.0, 160.0, 156.0, 158.0, 155.0, 156.0, 162.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 66.0, 63.0, 64.0, 62.0, 63.0, 63.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1465.4, "alertThreshold": 2.0}]} 03:53:29 INFO - Return code: 0 03:53:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:29 INFO - # TBPL SUCCESS # 03:53:29 INFO - Running post-action listener: _resource_record_post_action 03:53:29 INFO - [mozharness: 2016-10-12 10:53:29.517826Z] Finished run-tests step (success) 03:53:29 INFO - Running post-run listener: _resource_record_post_run 03:53:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 375177216; Read time: 92; Write time: 247180 03:53:29 INFO - TinderboxPrint: CPU usage
13.0% 03:53:29 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 92 03:53:29 INFO - TinderboxPrint: I/O write bytes / time
375,177,216 / 247,180 03:53:29 INFO - TinderboxPrint: CPU idle
8,264.1 (87.0%) 03:53:29 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 03:53:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116150272; Read time: 0; Write time: 102344 03:53:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250097664; Read time: 20; Write time: 144340 03:53:30 INFO - Running post-run listener: _upload_blobber_files 03:53:30 INFO - Blob upload gear active. 03:53:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:34 INFO - (blobuploader) - INFO - Done attempting. 03:53:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:35 INFO - (blobuploader) - INFO - Done attempting. 03:53:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:35 INFO - (blobuploader) - INFO - Done attempting. 03:53:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:35 INFO - Return code: 0 03:53:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9141cab6e093f6e49886ce485b0c78b2ce2122c9e025abd17b3726bf2ff685085973373f5e4ea508f54a45af7dda03b81407b73a44d79224fa7947823b2c8bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9f061fcebe556c4ed7cd9d64742600bb14d222a8ef1238810e96fd911eade1695835f5d07304c5330630ac1e6fa17514da714ae3dae1979ee8f0d81196509a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6484412a596b783f873bf516a55ebadcb27b836df271327bf954db27966caa7a4af60c0d306ab713fa01515482ae17ba857a0b14c5ebb640046034afaf1a1cf"} 03:53:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:35 INFO - Contents: 03:53:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9141cab6e093f6e49886ce485b0c78b2ce2122c9e025abd17b3726bf2ff685085973373f5e4ea508f54a45af7dda03b81407b73a44d79224fa7947823b2c8bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9f061fcebe556c4ed7cd9d64742600bb14d222a8ef1238810e96fd911eade1695835f5d07304c5330630ac1e6fa17514da714ae3dae1979ee8f0d81196509a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6484412a596b783f873bf516a55ebadcb27b836df271327bf954db27966caa7a4af60c0d306ab713fa01515482ae17ba857a0b14c5ebb640046034afaf1a1cf"} 03:53:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:35 INFO - Copying logs to upload dir... 03:53:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.827274 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-12 03:53:35.571931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 03:53:35.575569) ========= 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=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9141cab6e093f6e49886ce485b0c78b2ce2122c9e025abd17b3726bf2ff685085973373f5e4ea508f54a45af7dda03b81407b73a44d79224fa7947823b2c8bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9f061fcebe556c4ed7cd9d64742600bb14d222a8ef1238810e96fd911eade1695835f5d07304c5330630ac1e6fa17514da714ae3dae1979ee8f0d81196509a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6484412a596b783f873bf516a55ebadcb27b836df271327bf954db27966caa7a4af60c0d306ab713fa01515482ae17ba857a0b14c5ebb640046034afaf1a1cf"} build_url:https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/U3E9DaVlT9y8a3YLzC57-g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9141cab6e093f6e49886ce485b0c78b2ce2122c9e025abd17b3726bf2ff685085973373f5e4ea508f54a45af7dda03b81407b73a44d79224fa7947823b2c8bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9f061fcebe556c4ed7cd9d64742600bb14d222a8ef1238810e96fd911eade1695835f5d07304c5330630ac1e6fa17514da714ae3dae1979ee8f0d81196509a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6484412a596b783f873bf516a55ebadcb27b836df271327bf954db27966caa7a4af60c0d306ab713fa01515482ae17ba857a0b14c5ebb640046034afaf1a1cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 03:53:35.600414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:53:35.600701) ========= 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=523ca41ca1e0623de333ad52000001bf-1476263717.255160-1573599530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:53:35.685686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 03:53:35.685976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 03:53:35.686296) ========= ========= Total master_lag: 0.15 =========