builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1475836457.24 results: success (0) buildid: 20161007004004 builduid: c5063aeca4da4be780fa56f311ca0524 revision: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.240413) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.240882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.241194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.287884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.288174) ========= 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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 03:34:17-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2016-10-07 03:34:17 (17.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099030 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.413305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.413626) ========= 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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019238 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:17.476724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 03:34:17.477089) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 --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 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 --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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 03:34:18,026 truncating revision to first 12 chars 2016-10-07 03:34:18,026 Setting DEBUG logging. 2016-10-07 03:34:18,026 attempt 1/10 2016-10-07 03:34:18,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6eefe948a169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 03:34:18,750 unpacking tar archive at: mozilla-aurora-6eefe948a169/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 03:34:18.592806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:18.593455) ========= script_repo_revision: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:18.594354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:18.595010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 03:34:18.606731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-07 03:34:18.607096) ========= /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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:19 INFO - MultiFileLogger online at 20161007 03:34:19 in /builds/slave/test 03:34:19 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:34:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:19 INFO - {'append_to_log': False, 03:34:19 INFO - 'base_work_dir': '/builds/slave/test', 03:34:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:34:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:19 INFO - 'branch': 'Mozilla-Aurora', 03:34:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:19 INFO - 'config_files': ('talos/linux_config.py',), 03:34:19 INFO - 'default_actions': ('clobber', 03:34:19 INFO - 'read-buildbot-config', 03:34:19 INFO - 'download-and-extract', 03:34:19 INFO - 'populate-webroot', 03:34:19 INFO - 'create-virtualenv', 03:34:19 INFO - 'install', 03:34:19 INFO - 'run-tests'), 03:34:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:19 INFO - 'download_minidump_stackwalk': True, 03:34:19 INFO - 'download_symbols': 'ondemand', 03:34:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:19 INFO - 'installer_path': 'installer.exe', 03:34:19 INFO - 'log_level': 'info', 03:34:19 INFO - 'log_name': 'talos', 03:34:19 INFO - 'log_to_console': True, 03:34:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:19 INFO - 'opt_config_files': (), 03:34:19 INFO - 'pip_index': False, 03:34:19 INFO - 'sps_profile': False, 03:34:19 INFO - 'sps_profile_interval': 0, 03:34:19 INFO - 'suite': 'dromaeojs', 03:34:19 INFO - 'system_bits': '32', 03:34:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:19 INFO - 'title': 'talos-linux64-ix-048', 03:34:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:19 INFO - 'use_talos_json': True, 03:34:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:19 INFO - 'work_dir': 'build'} 03:34:19 INFO - [mozharness: 2016-10-07 10:34:19.243174Z] Running clobber step. 03:34:19 INFO - Running pre-action listener: _resource_record_pre_action 03:34:19 INFO - Running main action method: clobber 03:34:19 INFO - rmtree: /builds/slave/test/build 03:34:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:19 INFO - Running post-action listener: _resource_record_post_action 03:34:19 INFO - [mozharness: 2016-10-07 10:34:19.698588Z] Finished clobber step (success) 03:34:19 INFO - [mozharness: 2016-10-07 10:34:19.698691Z] Running read-buildbot-config step. 03:34:19 INFO - Running pre-action listener: _resource_record_pre_action 03:34:19 INFO - Running main action method: read_buildbot_config 03:34:19 INFO - Using buildbot properties: 03:34:19 INFO - { 03:34:19 INFO - "project": "", 03:34:19 INFO - "product": "firefox", 03:34:19 INFO - "script_repo_revision": "production", 03:34:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:34:19 INFO - "repository": "", 03:34:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:34:19 INFO - "buildid": "20161007004004", 03:34:19 INFO - "stage_platform": "linux64-pgo", 03:34:19 INFO - "basedir": "/builds/slave/test", 03:34:19 INFO - "nightly_build": "True", 03:34:19 INFO - "buildnumber": 814, 03:34:19 INFO - "slavename": "talos-linux64-ix-048", 03:34:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:34:19 INFO - "platform": "ubuntu64_hw", 03:34:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:34:19 INFO - "branch": "mozilla-aurora", 03:34:19 INFO - "repo_path": "releases/mozilla-aurora", 03:34:19 INFO - "revision": "6eefe948a16906fb0f4f9134ea75b52e0638c4f9", 03:34:19 INFO - "pgo_build": "True", 03:34:19 INFO - "builduid": "c5063aeca4da4be780fa56f311ca0524", 03:34:19 INFO - "slavebuilddir": "test" 03:34:19 INFO - } 03:34:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:34:19 INFO - Running post-action listener: _resource_record_post_action 03:34:19 INFO - [mozharness: 2016-10-07 10:34:19.701258Z] Finished read-buildbot-config step (success) 03:34:19 INFO - [mozharness: 2016-10-07 10:34:19.701347Z] Running download-and-extract step. 03:34:19 INFO - Running pre-action listener: _resource_record_pre_action 03:34:19 INFO - Running main action method: download_and_extract 03:34:19 INFO - mkdir: /builds/slave/test/build/tests 03:34:19 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:34:19 INFO - trying https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:34:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/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:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/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:34:20 INFO - Downloaded 1361 bytes. 03:34:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:34:20 INFO - Using the following test package requirements: 03:34:20 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:20 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:20 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:20 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'jsshell-linux-x86_64.zip'], 03:34:20 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:20 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:20 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:20 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:20 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:20 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:20 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:34:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:34:20 INFO - Expected file size: 21906937 03:34:25 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:34:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:34:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:34:26 INFO - Expected file size: 21906937 03:34:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:34:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:34:31 INFO - Expected file size: 14414059 03:34: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:34:31 INFO - trying https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:34:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/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:34:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/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:34:33 INFO - Downloaded 63954988 bytes. 03:34:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:34:33 INFO - mkdir: /builds/slave/test/properties 03:34:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:33 INFO - Contents: 03:34:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:34:33 INFO - Running post-action listener: _resource_record_post_action 03:34:33 INFO - Running post-action listener: set_extra_try_arguments 03:34:33 INFO - [mozharness: 2016-10-07 10:34:33.812973Z] Finished download-and-extract step (success) 03:34:33 INFO - [mozharness: 2016-10-07 10:34:33.813298Z] Running populate-webroot step. 03:34:33 INFO - Running pre-action listener: _resource_record_pre_action 03:34:33 INFO - Running main action method: populate_webroot 03:34:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:33 INFO - '--tppagecycles', 03:34:33 INFO - '7'], 03:34:33 INFO - 'tests': ['tsvgm']}}, 03:34:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['damp', 'tps']}, 03:34:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'tests': ['damp', 'tps']}, 03:34:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['dromaeo_dom']}, 03:34:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['basic_compositor_video']}, 03:34:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:34:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['a11yr', 03:34:33 INFO - 'ts_paint', 03:34:33 INFO - 'tpaint', 03:34:33 INFO - 'sessionrestore', 03:34:33 INFO - 'sessionrestore_no_auto_restore', 03:34:33 INFO - 'tabpaint']}, 03:34:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['tsvgx', 03:34:33 INFO - 'tsvgr_opacity', 03:34:33 INFO - 'tart', 03:34:33 INFO - 'tscrollx', 03:34:33 INFO - 'cart']}, 03:34:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:33 INFO - 'tsvgr_opacity', 03:34:33 INFO - 'tart', 03:34:33 INFO - 'tscrollx', 03:34:33 INFO - 'cart']}, 03:34:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'talos_options': ['--disable-e10s'], 03:34:33 INFO - 'tests': ['tp5o']}, 03:34:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'tests': ['tp5o']}, 03:34:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'talos_options': ['--disable-e10s', 03:34:33 INFO - '--xperf_path', 03:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:33 INFO - 'tests': ['tp5n']}, 03:34:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:33 INFO - 'talos_options': ['--xperf_path', 03:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:33 INFO - 'tests': ['tp5n']}}, 03:34:33 INFO - 'talos.zip': {'path': '', 03:34:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:33 INFO - Running post-action listener: _resource_record_post_action 03:34:33 INFO - [mozharness: 2016-10-07 10:34:33.831782Z] Finished populate-webroot step (success) 03:34:33 INFO - [mozharness: 2016-10-07 10:34:33.831872Z] Running create-virtualenv step. 03:34:33 INFO - Running pre-action listener: _resource_record_pre_action 03:34:33 INFO - Running main action method: create_virtualenv 03:34:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:33 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:34:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:33 INFO - Using real prefix '/usr' 03:34:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:36 INFO - Installing pip.................done. 03:34:36 INFO - Return code: 0 03:34:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:36 INFO - Using env: {'DISPLAY': ':0', 03:34:36 INFO - 'HOME': '/home/cltbld', 03:34:36 INFO - 'LANG': 'en_US.UTF-8', 03:34:36 INFO - 'LANGUAGE': 'en_US:en', 03:34:36 INFO - 'LOGNAME': 'cltbld', 03:34:36 INFO - 'MAIL': '/var/mail/cltbld', 03:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:36 INFO - 'MOZ_NO_REMOTE': '1', 03:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:36 INFO - 'NO_EM_RESTART': '1', 03:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:36 INFO - 'PWD': '/builds/slave/test', 03:34:36 INFO - 'SHELL': '/bin/bash', 03:34:36 INFO - 'SHLVL': '1', 03:34:36 INFO - 'TERM': 'linux', 03:34:36 INFO - 'TMOUT': '86400', 03:34:36 INFO - 'USER': 'cltbld', 03:34:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:36 INFO - '_': '/tools/buildbot/bin/python'} 03:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:36 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:34:36 INFO - Cleaning up... 03:34:36 INFO - Return code: 0 03:34:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:36 INFO - Using env: {'DISPLAY': ':0', 03:34:36 INFO - 'HOME': '/home/cltbld', 03:34:36 INFO - 'LANG': 'en_US.UTF-8', 03:34:36 INFO - 'LANGUAGE': 'en_US:en', 03:34:36 INFO - 'LOGNAME': 'cltbld', 03:34:36 INFO - 'MAIL': '/var/mail/cltbld', 03:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:36 INFO - 'MOZ_NO_REMOTE': '1', 03:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:36 INFO - 'NO_EM_RESTART': '1', 03:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:36 INFO - 'PWD': '/builds/slave/test', 03:34:36 INFO - 'SHELL': '/bin/bash', 03:34:36 INFO - 'SHLVL': '1', 03:34:36 INFO - 'TERM': 'linux', 03:34:36 INFO - 'TMOUT': '86400', 03:34:36 INFO - 'USER': 'cltbld', 03:34:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:36 INFO - '_': '/tools/buildbot/bin/python'} 03:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:36 INFO - Downloading/unpacking psutil>=3.1.1 03:34: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:34: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:34: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:34: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:34: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:34: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:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:38 INFO - Installing collected packages: psutil 03:34:38 INFO - Running setup.py install for psutil 03:34:38 INFO - building 'psutil._psutil_linux' extension 03:34:38 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:34:39 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:34:39 INFO - building 'psutil._psutil_posix' extension 03:34:39 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:34:39 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:34:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:39 INFO - Successfully installed psutil 03:34:39 INFO - Cleaning up... 03:34:39 INFO - Return code: 0 03:34:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34: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:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34: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 mozsystemmonitor==0.3 03:34:39 INFO - Using env: {'DISPLAY': ':0', 03:34:39 INFO - 'HOME': '/home/cltbld', 03:34:39 INFO - 'LANG': 'en_US.UTF-8', 03:34:39 INFO - 'LANGUAGE': 'en_US:en', 03:34:39 INFO - 'LOGNAME': 'cltbld', 03:34:39 INFO - 'MAIL': '/var/mail/cltbld', 03:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:39 INFO - 'MOZ_NO_REMOTE': '1', 03:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:39 INFO - 'NO_EM_RESTART': '1', 03:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:39 INFO - 'PWD': '/builds/slave/test', 03:34:39 INFO - 'SHELL': '/bin/bash', 03:34:39 INFO - 'SHLVL': '1', 03:34:39 INFO - 'TERM': 'linux', 03:34:39 INFO - 'TMOUT': '86400', 03:34:39 INFO - 'USER': 'cltbld', 03:34:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:39 INFO - '_': '/tools/buildbot/bin/python'} 03:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:41 INFO - Installing collected packages: mozsystemmonitor 03:34:41 INFO - Running setup.py install for mozsystemmonitor 03:34:41 INFO - Successfully installed mozsystemmonitor 03:34:41 INFO - Cleaning up... 03:34:41 INFO - Return code: 0 03:34:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:41 INFO - Using env: {'DISPLAY': ':0', 03:34:41 INFO - 'HOME': '/home/cltbld', 03:34:41 INFO - 'LANG': 'en_US.UTF-8', 03:34:41 INFO - 'LANGUAGE': 'en_US:en', 03:34:41 INFO - 'LOGNAME': 'cltbld', 03:34:41 INFO - 'MAIL': '/var/mail/cltbld', 03:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:41 INFO - 'MOZ_NO_REMOTE': '1', 03:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:41 INFO - 'NO_EM_RESTART': '1', 03:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:41 INFO - 'PWD': '/builds/slave/test', 03:34:41 INFO - 'SHELL': '/bin/bash', 03:34:41 INFO - 'SHLVL': '1', 03:34:41 INFO - 'TERM': 'linux', 03:34:41 INFO - 'TMOUT': '86400', 03:34:41 INFO - 'USER': 'cltbld', 03:34:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:41 INFO - '_': '/tools/buildbot/bin/python'} 03:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:44 INFO - warning: no files found matching '*.txt' 03:34:44 INFO - no previously-included directories found matching 'build' 03:34:44 INFO - no previously-included directories found matching 'dist' 03:34:44 INFO - no previously-included directories found matching '.git*' 03:34:44 INFO - Installing collected packages: jsonschema, functools32 03:34:44 INFO - Running setup.py install for functools32 03:34:44 INFO - warning: no files found matching '*.txt' 03:34:44 INFO - no previously-included directories found matching 'build' 03:34:44 INFO - no previously-included directories found matching 'dist' 03:34:44 INFO - no previously-included directories found matching '.git*' 03:34:44 INFO - Successfully installed jsonschema functools32 03:34:44 INFO - Cleaning up... 03:34:44 INFO - Return code: 0 03:34:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:44 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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:44 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:34:44 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:34:44 INFO - Using env: {'DISPLAY': ':0', 03:34:44 INFO - 'HOME': '/home/cltbld', 03:34:44 INFO - 'LANG': 'en_US.UTF-8', 03:34:44 INFO - 'LANGUAGE': 'en_US:en', 03:34:44 INFO - 'LOGNAME': 'cltbld', 03:34:44 INFO - 'MAIL': '/var/mail/cltbld', 03:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:44 INFO - 'MOZ_NO_REMOTE': '1', 03:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:44 INFO - 'NO_EM_RESTART': '1', 03:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:44 INFO - 'PWD': '/builds/slave/test', 03:34:44 INFO - 'SHELL': '/bin/bash', 03:34:44 INFO - 'SHLVL': '1', 03:34:44 INFO - 'TERM': 'linux', 03:34:44 INFO - 'TMOUT': '86400', 03:34:44 INFO - 'USER': 'cltbld', 03:34:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:44 INFO - '_': '/tools/buildbot/bin/python'} 03:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:44 INFO - Cleaning up... 03:34:44 INFO - Return code: 0 03:34:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:44 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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:44 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:34:44 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:34:44 INFO - Using env: {'DISPLAY': ':0', 03:34:44 INFO - 'HOME': '/home/cltbld', 03:34:44 INFO - 'LANG': 'en_US.UTF-8', 03:34:44 INFO - 'LANGUAGE': 'en_US:en', 03:34:44 INFO - 'LOGNAME': 'cltbld', 03:34:44 INFO - 'MAIL': '/var/mail/cltbld', 03:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:44 INFO - 'MOZ_NO_REMOTE': '1', 03:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:44 INFO - 'NO_EM_RESTART': '1', 03:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:44 INFO - 'PWD': '/builds/slave/test', 03:34:44 INFO - 'SHELL': '/bin/bash', 03:34:44 INFO - 'SHLVL': '1', 03:34:44 INFO - 'TERM': 'linux', 03:34:44 INFO - 'TMOUT': '86400', 03:34:44 INFO - 'USER': 'cltbld', 03:34:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:44 INFO - '_': '/tools/buildbot/bin/python'} 03:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 INFO - Downloading docopt-0.6.1.tar.gz 03:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:47 INFO - Running setup.py install for blobuploader 03:34:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:47 INFO - Running setup.py install for requests 03:34:47 INFO - Running setup.py install for docopt 03:34:47 INFO - Successfully installed blobuploader requests docopt 03:34:47 INFO - Cleaning up... 03:34:47 INFO - Return code: 0 03:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:47 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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:47 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:34:47 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:34:47 INFO - Using env: {'DISPLAY': ':0', 03:34:47 INFO - 'HOME': '/home/cltbld', 03:34:47 INFO - 'LANG': 'en_US.UTF-8', 03:34:47 INFO - 'LANGUAGE': 'en_US:en', 03:34:47 INFO - 'LOGNAME': 'cltbld', 03:34:47 INFO - 'MAIL': '/var/mail/cltbld', 03:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:47 INFO - 'MOZ_NO_REMOTE': '1', 03:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:47 INFO - 'NO_EM_RESTART': '1', 03:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:47 INFO - 'PWD': '/builds/slave/test', 03:34:47 INFO - 'SHELL': '/bin/bash', 03:34:47 INFO - 'SHLVL': '1', 03:34:47 INFO - 'TERM': 'linux', 03:34:47 INFO - 'TMOUT': '86400', 03:34:47 INFO - 'USER': 'cltbld', 03:34:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:47 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:48 INFO - Running setup.py (path:/tmp/pip-TczIL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:48 INFO - Running setup.py (path:/tmp/pip-YR9fYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:48 INFO - Running setup.py (path:/tmp/pip-XSMPWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:48 INFO - Running setup.py (path:/tmp/pip-FU_njH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:48 INFO - Running setup.py (path:/tmp/pip-iXwo4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:48 INFO - Running setup.py (path:/tmp/pip-1EoxMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:48 INFO - Running setup.py (path:/tmp/pip-W6khjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:48 INFO - Running setup.py (path:/tmp/pip-eblrGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:48 INFO - Running setup.py (path:/tmp/pip-amahqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:48 INFO - Running setup.py (path:/tmp/pip-qfzsIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:48 INFO - Running setup.py (path:/tmp/pip-bEgdVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:48 INFO - Running setup.py (path:/tmp/pip-ikzF6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:49 INFO - Running setup.py (path:/tmp/pip-lIpE2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:49 INFO - Running setup.py (path:/tmp/pip-iLxIkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:49 INFO - Running setup.py (path:/tmp/pip-IMv5lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:49 INFO - Running setup.py (path:/tmp/pip-KIJBKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:49 INFO - Running setup.py (path:/tmp/pip-jMk7Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:49 INFO - Running setup.py install for manifestparser 03:34:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozcrash 03:34:49 INFO - Running setup.py install for mozdebug 03:34:49 INFO - Running setup.py install for mozdevice 03:34:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozfile 03:34:49 INFO - Running setup.py install for mozhttpd 03:34:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozinfo 03:34:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozInstall 03:34:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozleak 03:34:50 INFO - Running setup.py install for mozlog 03:34:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for moznetwork 03:34:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozprocess 03:34:50 INFO - Running setup.py install for mozprofile 03:34:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozrunner 03:34:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Running setup.py install for mozscreenshot 03:34:50 INFO - Running setup.py install for moztest 03:34:51 INFO - Running setup.py install for mozversion 03:34:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:51 INFO - Cleaning up... 03:34:51 INFO - Return code: 0 03:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:51 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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:51 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:34:51 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:34:51 INFO - Using env: {'DISPLAY': ':0', 03:34:51 INFO - 'HOME': '/home/cltbld', 03:34:51 INFO - 'LANG': 'en_US.UTF-8', 03:34:51 INFO - 'LANGUAGE': 'en_US:en', 03:34:51 INFO - 'LOGNAME': 'cltbld', 03:34:51 INFO - 'MAIL': '/var/mail/cltbld', 03:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:51 INFO - 'MOZ_NO_REMOTE': '1', 03:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:51 INFO - 'NO_EM_RESTART': '1', 03:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:51 INFO - 'PWD': '/builds/slave/test', 03:34:51 INFO - 'SHELL': '/bin/bash', 03:34:51 INFO - 'SHLVL': '1', 03:34:51 INFO - 'TERM': 'linux', 03:34:51 INFO - 'TMOUT': '86400', 03:34:51 INFO - 'USER': 'cltbld', 03:34:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:51 INFO - '_': '/tools/buildbot/bin/python'} 03:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:51 INFO - Running setup.py (path:/tmp/pip-PwaHf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:51 INFO - Running setup.py (path:/tmp/pip-jucnRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:51 INFO - Running setup.py (path:/tmp/pip-yL36t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:51 INFO - Running setup.py (path:/tmp/pip-92Jfo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:51 INFO - Running setup.py (path:/tmp/pip-GmSAMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:51 INFO - Running setup.py (path:/tmp/pip-LSh4N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:51 INFO - Running setup.py (path:/tmp/pip-7eq_hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:51 INFO - Running setup.py (path:/tmp/pip-tE5D4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:51 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:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:51 INFO - Running setup.py (path:/tmp/pip-USTi5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:52 INFO - Running setup.py (path:/tmp/pip-m8vtVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:52 INFO - Running setup.py (path:/tmp/pip-jKwtXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:52 INFO - Running setup.py (path:/tmp/pip-1q6dTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:52 INFO - Running setup.py (path:/tmp/pip-Zq4a1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:52 INFO - Running setup.py (path:/tmp/pip-EqNZAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:52 INFO - Running setup.py (path:/tmp/pip-3tJSln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:52 INFO - Running setup.py (path:/tmp/pip-htVFFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:52 INFO - Running setup.py (path:/tmp/pip-em_LAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:54 INFO - Downloading blessings-1.6.tar.gz 03:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:54 INFO - Installing collected packages: blessings 03:34:54 INFO - Running setup.py install for blessings 03:34:54 INFO - Successfully installed blessings 03:34:54 INFO - Cleaning up... 03:34:54 INFO - Return code: 0 03:34:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:55 INFO - Reading from file tmpfile_stdout 03:34:55 INFO - Current package versions: 03:34:55 INFO - argparse == 1.2.1 03:34:55 INFO - blessings == 1.6 03:34:55 INFO - blobuploader == 1.2.4 03:34:55 INFO - docopt == 0.6.1 03:34:55 INFO - functools32 == 3.2.3-2 03:34:55 INFO - jsonschema == 2.5.1 03:34:55 INFO - manifestparser == 1.1 03:34:55 INFO - mozInstall == 1.12 03:34:55 INFO - mozcrash == 0.17 03:34:55 INFO - mozdebug == 0.1 03:34:55 INFO - mozdevice == 0.48 03:34:55 INFO - mozfile == 1.2 03:34:55 INFO - mozhttpd == 0.7 03:34:55 INFO - mozinfo == 0.9 03:34:55 INFO - mozleak == 0.1 03:34:55 INFO - mozlog == 3.4 03:34:55 INFO - moznetwork == 0.27 03:34:55 INFO - mozprocess == 0.23 03:34:55 INFO - mozprofile == 0.28 03:34:55 INFO - mozrunner == 6.12 03:34:55 INFO - mozscreenshot == 0.1 03:34:55 INFO - mozsystemmonitor == 0.3 03:34:55 INFO - moztest == 0.7 03:34:55 INFO - mozversion == 1.4 03:34:55 INFO - psutil == 3.1.1 03:34:55 INFO - requests == 1.2.3 03:34:55 INFO - wsgiref == 0.1.2 03:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:55 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 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:55 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:34:55 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:34:55 INFO - Using env: {'DISPLAY': ':0', 03:34:55 INFO - 'HOME': '/home/cltbld', 03:34:55 INFO - 'LANG': 'en_US.UTF-8', 03:34:55 INFO - 'LANGUAGE': 'en_US:en', 03:34:55 INFO - 'LOGNAME': 'cltbld', 03:34:55 INFO - 'MAIL': '/var/mail/cltbld', 03:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:55 INFO - 'MOZ_NO_REMOTE': '1', 03:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:55 INFO - 'NO_EM_RESTART': '1', 03:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:55 INFO - 'PWD': '/builds/slave/test', 03:34:55 INFO - 'SHELL': '/bin/bash', 03:34:55 INFO - 'SHLVL': '1', 03:34:55 INFO - 'TERM': 'linux', 03:34:55 INFO - 'TMOUT': '86400', 03:34:55 INFO - 'USER': 'cltbld', 03:34:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:55 INFO - '_': '/tools/buildbot/bin/python'} 03:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 INFO - Cleaning up... 03:34:55 INFO - Return code: 0 03:34:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34: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:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c40737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', '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:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:55 INFO - Using env: {'DISPLAY': ':0', 03:34:55 INFO - 'HOME': '/home/cltbld', 03:34:55 INFO - 'LANG': 'en_US.UTF-8', 03:34:55 INFO - 'LANGUAGE': 'en_US:en', 03:34:55 INFO - 'LOGNAME': 'cltbld', 03:34:55 INFO - 'MAIL': '/var/mail/cltbld', 03:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:55 INFO - 'MOZ_NO_REMOTE': '1', 03:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:55 INFO - 'NO_EM_RESTART': '1', 03:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:55 INFO - 'PWD': '/builds/slave/test', 03:34:55 INFO - 'SHELL': '/bin/bash', 03:34:55 INFO - 'SHLVL': '1', 03:34:55 INFO - 'TERM': 'linux', 03:34:55 INFO - 'TMOUT': '86400', 03:34:55 INFO - 'USER': 'cltbld', 03:34:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:55 INFO - '_': '/tools/buildbot/bin/python'} 03:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:55 INFO - Cleaning up... 03:34:55 INFO - Return code: 0 03:34:55 INFO - Running post-action listener: _resource_record_post_action 03:34:55 INFO - Running post-action listener: _start_resource_monitoring 03:34:55 INFO - Starting resource monitoring. 03:34:55 INFO - [mozharness: 2016-10-07 10:34:55.496675Z] Finished create-virtualenv step (success) 03:34:55 INFO - [mozharness: 2016-10-07 10:34:55.497158Z] Running install step. 03:34:55 INFO - Running pre-action listener: _resource_record_pre_action 03:34:55 INFO - Running main action method: install 03:34:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:55 INFO - Reading from file tmpfile_stdout 03:34:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:55 INFO - Reading from file tmpfile_stdout 03:34:55 INFO - Output received: 03:34:55 INFO - Usage: mozinstall [options] installer 03:34:55 INFO - Options: 03:34:55 INFO - -h, --help show this help message and exit 03:34:55 INFO - -d DEST, --destination=DEST 03:34:55 INFO - Directory to install application into. [default: 03:34:55 INFO - "/builds/slave/test"] 03:34:55 INFO - --app=APP Application being installed. [default: firefox] 03:34:55 INFO - mkdir: /builds/slave/test/build/application 03:34:55 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:34:55 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:35:11 INFO - Reading from file tmpfile_stdout 03:35:11 INFO - Output received: 03:35:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:11 INFO - Running post-action listener: _resource_record_post_action 03:35:11 INFO - [mozharness: 2016-10-07 10:35:11.759357Z] Finished install step (success) 03:35:11 INFO - [mozharness: 2016-10-07 10:35:11.759604Z] Running run-tests step. 03:35:11 INFO - Running pre-action listener: _resource_record_pre_action 03:35:11 INFO - Running main action method: run_tests 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:11 INFO - Python 2.7.3 03:35:11 INFO - Return code: 0 03:35:11 INFO - grabbing minidump binary from tooltool 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:11 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 0x1ca6f60>, '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 0x1ca7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:11 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:35:11 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:35:11 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:35:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:11 INFO - Return code: 0 03:35:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:11 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/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:35:11 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/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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:35:11 INFO - Using env: {'DISPLAY': ':0', 03:35:11 INFO - 'HOME': '/home/cltbld', 03:35:11 INFO - 'LANG': 'en_US.UTF-8', 03:35:11 INFO - 'LANGUAGE': 'en_US:en', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MAIL': '/var/mail/cltbld', 03:35:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SHLVL': '1', 03:35:11 INFO - 'TERM': 'linux', 03:35:11 INFO - 'TMOUT': '86400', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - '_': '/tools/buildbot/bin/python'} 03:35:11 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/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:35:12 INFO - mozversion application_buildid: 20161007004004 03:35:12 INFO - mozversion application_changeset: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 03:35:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:12 INFO - mozversion application_name: Firefox 03:35:12 INFO - mozversion application_remotingname: firefox-dev 03:35:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:12 INFO - mozversion application_vendor: Mozilla 03:35:12 INFO - mozversion application_version: 51.0a2 03:35:12 INFO - mozversion platform_buildid: 20161007004004 03:35:12 INFO - mozversion platform_changeset: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 03:35:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:12 INFO - mozversion platform_version: 51.0a2 03:35:12 INFO - using testdate: 1475836512 03:35:12 INFO - actual date: 1475836512 03:35:12 INFO - starting webserver on 'localhost:52196' 03:35:12 INFO - SUITE-START | Running 2 tests 03:35:12 INFO - TEST-START | dromaeo_css 03:35:12 INFO - operating with platform_type : linux_ 03:35:12 INFO - Initialising browser for dromaeo_css test... 03:35:12 INFO - TEST-INFO | started process 25337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGroREz/profile http://localhost:52196/getInfo.html) 03:35:16 INFO - PROCESS | 25337 | __metrics Screen width/height:1600/1200 03:35:16 INFO - PROCESS | 25337 | colorDepth:24 03:35:16 INFO - PROCESS | 25337 | Browser inner width/height: 1024/697 03:35:16 INFO - PROCESS | 25337 | __metrics 03:35:16 INFO - PROCESS | 25337 | 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:35:16 INFO - PROCESS | 25337 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:17 INFO - PROCESS | 25337 | console.error: PushService: 03:35:17 INFO - PROCESS | 25337 | stateChangeProcessEnqueue: Error transitioning state 03:35:17 INFO - PROCESS | 25337 | UnknownError 03:35:18 INFO - TEST-INFO | 25337: exit 0 03:35:18 INFO - Browser initialized. 03:35:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:18 INFO - TEST-INFO | started process 25427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGroREz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:29 INFO - PROCESS | 25427 | RSS: Main: 145035264 03:35:29 INFO - PROCESS | 25427 | 03:36:20 INFO - PROCESS | 25427 | 1475836580915 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:38:30 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52196/tests/dromaeo/cssquery-ext.html) 03:38:31 INFO - PROCESS | 25427 | RSS: Main: 240017408 03:38:31 INFO - PROCESS | 25427 | 03:41:33 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-ext.html (next: http://localhost:52196/tests/dromaeo/cssquery-jquery.html) 03:41:33 INFO - PROCESS | 25427 | RSS: Main: 227753984 03:41:33 INFO - PROCESS | 25427 | 03:44:35 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52196/tests/dromaeo/cssquery-mootools.html) 03:44:36 INFO - PROCESS | 25427 | RSS: Main: 230977536 03:44:36 INFO - PROCESS | 25427 | 03:47:38 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52196/tests/dromaeo/cssquery-prototype.html) 03:47:39 INFO - PROCESS | 25427 | RSS: Main: 219361280 03:47:39 INFO - PROCESS | 25427 | 03:50:41 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52196/tests/dromaeo/cssquery-yui.html) 03:50:42 INFO - PROCESS | 25427 | RSS: Main: 176631808 03:50:42 INFO - PROCESS | 25427 | 03:53:44 INFO - PROCESS | 25427 | Cycle 1(1): loaded http://localhost:52196/tests/dromaeo/cssquery-yui.html (next: http://localhost:52196/tests/dromaeo/cssquery-dojo.html) 03:53:45 INFO - PROCESS | 25427 | RSS: Main: 264654848 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | __start_tp_report 03:53:45 INFO - PROCESS | 25427 | _x_x_mozilla_page_load 03:53:45 INFO - PROCESS | 25427 | _x_x_mozilla_page_load_details 03:53:45 INFO - PROCESS | 25427 | |i|pagename|runs| 03:53:45 INFO - PROCESS | 25427 | |0;dojo.html;3150.684931506849;3192.4892017277234;3211.100891750311;3219.1791093271213;3249.870005199792;5530.4193059728705;5619.887602247958;5636.689982050985;5646.632968857021;5660.2358681577925;5483;5639.718014099289;5644.604877658566;5654.915176272349;5671.461211184941;5063.645544811865;5091.1090559152;5117.744112794364;5141.794328226866;5162.741862906859;4963.6277279204205;5112.565431938289;5156.92264616031;5158.484151584849;5158.793648254065;4938.308636790852;5005.774740136702;5025.020121076392;5048.596112311025;5061.316722242487;5055.545000949914;5089.770960306795;5091.363579552556;5175.301334319856;5198.740062996835;4998.650094493387;5085.389753229599;5126.384833819928;5142.125838607446;5146.742662866842;5366.838994830161;5404.351477822647;5418.376886658046;5490.203920431555;5573.024720673866;5835.941640583625;5858.2677165354335;5863.472287494146;5946.405359464062;5955.940440595626;5994.97002514989;5995.760169593211;6001.129836173774;6004.78983235589;6009.278886533601;5428.945710542923;5487.5609951203805;5514.834554963398;5567.331920169525;5572.888542229132;6111.083337499322;6144.539159563051;6153.2000839890525;6153.446189842935;6155.230596175478;5876.1773351729935;5905.881882362329;5913.29040515141;5917.733701983421;5918.082697181943;5781.335146458127;5795.739191736382;5815.389384114692;5830.912536311958;5845.649261044351;5844.064949608042;5844.298684157929;5849.912251316234;5853.64878107315;5873.735681894325;5762.423757624204;5825.242718446575;5826.504747096459;5854.2389489366105;5873.735681894325;4491.438570178728;4528.230200865861;4545.931811022837;4560.749158796231;4592.196365636067;4090.5909409058854;4097.85657501986;4099.405586190045;4108;4132.793360331972;5708.686022268815;5717.085266357363;5719.542436605145;5720.48515633595;5723.456271654186;5822.94177058224;5852.4440178183;5889.234399528034;6001.819945401645;6032.034874420072;5572;5632.662040277596;5640.294963129609;5655.915161272585;5673.092305231144;4979.178435558092;4979.3277907482025;4979.4771548987555;4992.151334273182;4997.600191984632;5900.881982360243;6024.246969128859;6129.601575897553;6164.630122192593;6168.907466388007;5774.3648198697265;5907.261592300963;5927.8221653350465;6033.42682445167;6072.028475443908;6180.3848182912825;6199.28708198563;6213.316535181036;6226.813195604139;6229.096780966644;5751.252337196138;5942;5947.405259474018;5954.553408494294;5963.850903727268;5826.184334193301;5873.324567674772;5875.118732190205;5878.882422351615;5975.043992961106;5733.4266573344;5758.971205143947;5760.0783874579865;5782.681952492653;5786.132080188006;5786.247787787561;5787.652740835563;5788.160716696139;5793.8551536211935;5794.855128621818;5558.944410555842;5585.385607583082;5676.886462270649;5708.115242137475;5720.313562372376;5834.416558344302;5838.737256823369;5839.766409343579;5840.737166827418;5891.1457838612305;5530.944690553204;5701.945140149086;5708.372079071216;5710.685912274865;5717.514011308919 03:53:45 INFO - PROCESS | 25427 | |1;ext.html;585.3794977324037;604.655346452522;623.2023010546496;625.334019269478;641.6022066318882;33945;37303.626963730356;37321.06697332564;37398.439023414605;37402.43896341554;47760.76119619406;48267.75866120673;48557.757211213895;51689;51915.48084519154;9255.259579233645;9393.20157786589;9403.482808445533;9409.153176214139;9411.95294023529;8632.870506942401;8785.956070219672;9250.25997920168;9343.159115679588;9353.95323023384;11110.44447777612;11309.717257068556;11321.547138114507;11717.824232636518;11722.120840936965;11214.495347709331;11274.605388811353;11277.266977646426;11317.886821131808;11346.829797553044;11097.1122310215;11156.10751139915;11166.497507612177;11167.83248251277;11176.05003574689;45185.54814451879;45227;45464;45488;45558.772206138754;3406.6252712201886;3592.982035089834;3697.759645623026;3953.2488827122756;4461.286194208911;34059.659403405894;34390.140246493786;34548.82725586381;34678.30643387143;34811.12972175691;4413.823447062114;4495.662825288084;4500.347449619787;4546.47715512717;4673.924997250651;277218;281053;281795;282383;282812;62536.687316563126;62851.685741571;62888.68555657192;62891.685541572915;62988.685056574424;39768.60231397649;39854.402183967264;40089.59910400917;42974.57025429768;42986.355204671956;18268;18456.630867382846;18457.5385615358;18466.538336541424;18469.630607388044;14098.788518172236;14192.85807141936;14205.147691138565;14206.147631142165;14206.715865682629;18028.54928626795;18045.909770451064;19435.705566527307;19804.603907921763;20015.498062742157;7276.308750668678;7382.741604043833;7476.663550140257;7559.5809341011445;7684.423668224794;991.6430085169334;1078.2021304234809;1087.853139826129;1119.1270808769173;1207.722223888493;33948.830255849054;33983.49024764581;34291.65708342884;34554.30891382158;34605.307893841986;1169.5264515549552;1205.8552973643043;1227;1266.4807428954084;1278.7186818899827;17978.820211797974;18037;18180.81819181791;18195;18198.63602727938;161758;162702;162924;163079;163310;61841.690791545756;62160.067598986054;62445.68777156085;62463.37536624575;62485.68757156185;1386.7018591002982;1429.7926800614061;1432.3196481671123;1435.5836807325759;1468.4419920430169;31723.84138079295;33087.33825323432;33530.93958800118;33578.664213358534;34011.82994085113;53456.198157028455;53858.19212711734;54013.459865400844;54081.72959135179;54173;468906;471297;472034;472099;473887;27262.727372726018;27533.17400477989;28871.422571548872;29953.70046299509;31045.534316984813;45432;49625.255621166434;50150.49849501458;50211.497885022145;50355.24467132923;42562;42658.360124598774;43384;44153;44319.33520997123;42558;42606.360904587076;42983.495577654634;43174.568254317055;43906.34140487959;42717.35923961205;43578.56421435872;43750.124997500505;43799.34300985424;43835.342469863615;35963.46054809232;38073.61926380811;38225.23549529049;38614.80692596519;38772.80613596914;28703;29241.85379073091;29349.41301173922;29482.557761633165;29621 03:53:45 INFO - PROCESS | 25427 | |2;jquery.html;429.4952459151796;429.93550967354895;436.99563004369946;437.71548493479247;447.76492341520697;19105.42683719487;19258.325958591453;20479.795202047975;20561;20762.792372076274;19214;19438.319658811943;20566.177352905866;20742;20809.687854682194;5664.122061080539;5929.1995580596495;5932.169496270526;5935.821925342247;5936.673482958436;5741.311042674884;5880.5883588148845;5905.261842269716;5932.6143800653035;5951.464368206861;5892.616979896293;5893.528517718593;5896.174535565003;5896.174535565025;5896.941030589682;5694.402087780785;5842;5870.11948207768;5894.3810899855325;5897.734601942923;5329.760160792774;5336.252924590561;5340.465953404668;5344.22508736235;5346.625736198468;22595.20916767905;23292;24277.87861060701;24457.510849783084;24619.63070553943;3025.4554180247546;3038.9088327349996;3051.0694238257324;3065.6167979002626;3117.563541104247;12407.813882791765;14551.126932383984;14866.702665946621;15465.458708945132;15655.373785048585;1940.922363105474;1989.9303524376721;2156.7196264485674;2338.8128949683983;2415.975840241593;92492;93770;94457.52771236168;98276;99967.50016249945;18365.265389384276;18422.631547369245;18445.5388615283;18601.883886966825;18664.04027577112;36712.449313260324;36728;36803;36866;36884;10408.271421000609;10500.684979450629;10534.946505349557;10741.462926853626;10960.780784384428;8890.422122562013;8898.688545900863;8955.552222388855;9035.870516185476;9225.49259790718;9318.767030824283;9534.18959388446;9644.228461723045;9671.226301895831;9701.320907536405;3478.843452044664;3499.600159936046;3597.5323207982797;3671.6231413220044;3693.7414380993073;895.6641259527677;969.2052516936186;1004.5630150884389;1006.8741407324085;1042.9634962776267;20423.753387127403;20547.253483454075;20572.279970200972;20731;20859.37421877346;1023.902729240721;1033.204432586919;1034.384541197986;1043.5929987304958;1082.426314053553;10567.524461399256;11281.887181128248;11454.656360309038;11498;11563.6530904073;461034;479109;489293;489405;524792;94886.52556737172;98911.50544247232;99770;104234;105117;1044.8902865199198;1098.8626421697288;1102.079763397556;1121.9214654974237;1123.4607388453587;17670;18151;18159.727604086213;18258.45224643263;18588.628227435645;43563.56436435722;45139.54860451485;45278.32082518699;45741.542584573726;46391;60977.695111525936;62035;62197.37802621916;62279.6886015567;62941.37058629355;8517.659293628185;8762.693305734269;8784.91215087841;8917.019127896056;8928.375013749235;12359.876401235873;13053.934730326668;13303.534376296782;13576.59270221895;13582.049256551947;11493.597724079951;11607.36159511235;11633;11869;12013.819792702941;11289.887101128883;11713.590024349107;11767.176297659424;12033.217840840318;12064.705561965016;10937.56249750001;11980.64058078259;12217.877821221675;12319.384030798245;12361.320127393079;7598.240175982579;7900.604969751605;8596.054434012378;8762.211400973943;9130.680426185052;10763.784724305626;10890.782184356427;11877.22798018126;11905.702357441134;12142.75714485723 03:53:45 INFO - PROCESS | 25427 | |3;mootools.html;1297.351324337831;1417.5959851442342;1435.3540906592034;1475.9262036898153;1862.1341076399472;7875.251851074146;8762.86855697165;8967.955160224197;9091.363604547667;9516.76208094798;9284.071592840712;9335.62657493701;9339.76650583734;9348.626054957793;9360.110789475006;2453.521563295158;2481.2308184462872;2482.056818409002;2482.5283196192668;2482.7765501104896;2411.5779738545684;2472.196536125766;2472.9629055564183;2473.208573256559;2478.4881222454287;2427.174760581402;2438.317271164077;2515.4843257132243;2516.660250866137;2517.244826552036;2419.1653879411574;2435.9391015224674;2441.4750828571764;2445.119756887519;2446.584080706284;2408.759124087577;2434.318390850565;2440.877956102188;2443.68232129822;2463.864487453189;8939.41893776909;9260.351775375726;9272.675456359062;9336.766580835465;9363.76590585234;5435.592330575183;5608.074667679828;5614.354349249807;5617.325920889479;5621.831345059655;3392.8982130536124;3414.556107706007;3450.603180634234;3466.5666791651042;3481.5125882376487;1205.439470646145;1254.1534464236695;1281.592751549836;1313.9145955512956;1337.224409842289;12753.744925101446;12786.360681965958;12863;12913.870861291362;12927.15973461722;4735.360726301974;4742.511888444097;4760.071786001697;4883.51164883516;4951.207806750903;10181.74545636365;10188.286819922534;10189;10199.235057370726;10201.74495637615;5550.611457198038;5566.471185237396;5568.44315568448;5570.944290557042;5575.749091290902;4573.49691533931;4711.905761884743;4990.30135780991;5051.823186188466;5196.1166601677805;4114.136031433432;4118.608732170439;4225.809838557272;4270.10327831159;4312.913741725148;1320.1682939748089;1351.3783659516537;1351.9797203041962;1357.0771875124813;1359.306753555674;824.698984870518;930.8603709443502;954.6420092465326;973.3235401396104;992.6029588164647;6200.3799620037635;6205.410486003822;6217.378262173836;6219.284782250099;6342.143810585604;459.0635104387013;471.49785478465327;471.58029353875077;477.9928301075487;497.8282492540068;4240.724352917112;4248.745075295492;4249.426327445755;4302.118065796504;4360.803763830635;11119.499622517005;11420.600278990196;11518.481668324945;11526;11536.711582210512;10676.252662313564;11172.162087843282;11186.32882027081;11417.37204453763;11424.543018279343;8443.282321002784;8666.696665616799;8673.132686731402;8686;8693.739187824376;6035.486983606443;6043.697815109139;6062.090686397076;6122.938770612237;6468.644224567505;10552.050315471644;10578.841317380091;10592.841107383241;10704.197185211297;10710.089642380484;10149.137323327599;10509.369437833755;10513.474326283807;10606.045455909005;10899.673009809718;6802.659867006729;6998.685059172248;7873.212678732081;8169.305609023299;8315.584220788814;8651.826963460822;9075.863862042206;9076.228520575562;9078.818423631623;9086.22767064807;7814.882776758467;7821.491603045783;7952.324052455606;8069.87895181561;8091.029076510857;7667.731629392944;7882.408819338687;7904.170062143392;7938.24586664266;8025.919740802751;7228.241034691492;7282;7340.743073992385;7341.375983041501;7354.926450735638;5202.869928251824;5299.364076310867;5313.734313284398;5331.253624492651;5406.268079079095;5228.372595288438;5253.711045892513;5279;5282.418933917189;5372 03:53:45 INFO - PROCESS | 25427 | |4;prototype.html;324.7027281979992;346.9150058235732;348.65483171660065;349.8145982629206;353.2405328543629;5531.197976293435;5554.638948468347;5557.833265002051;5587.245721827552;5607.495325420711;5223.921641175385;5331.893362132755;5355.410904800478;5379.9731001344935;5523.475269849358;4152.335626299792;4154.335306350992;4300.956990430087;4311.9784401078105;4317.805698743564;4290.2706539888295;4305.784710764449;4321.481422229337;4325.52419233884;4327.935080973788;4058.9594104059024;4231.76725280111;4234.237837189305;4249.723767955088;4281.422008028923;4230.51349094855;4236.089240813225;4242.748389225155;4247.596478334538;4255.361695745632;3749.7562658427387;3761.586225515191;3769.4534292527705;3775.3959366501504;3790.3556395412847;5294.867628309285;5363.195520671891;5387.757550910218;5394.651337165708;5403.918941215846;4904.7383489979475;4907.558319751204;4924.079608952511;4929.975350123263;4941.925871111936;5738.225339579145;5755.366909639936;5767.8558036049435;5769.14427358456;5795.275590551181;4053.27041132596;4112.629863312286;4145.585441455861;4151.813168407429;4151.858238984273;5890.646561206384;5957.91063134049;5980.730867110947;5994.490468310199;5999.430054144849;4154.774341569244;4164.8542301019315;4175.935136540163;4198.28629133042;4204.1171354016;4112.383142528644;4236.385724069993;4284.250256205151;4294.398784170218;4320.4599425071865;4906.705597664151;4910.8281210157475;4925.335079764258;4929.186684197068;4947.505249475095;5829.446202610745;5838.678872662044;5846.0061789495885;5873.177755114288;5916.408359164136;1435.4473527691914;1445.1906932118047;1456.2936975566843;1458.3145921416917;1460.8466111058399;936.681528280388;940.2584735430382;940.5156344482597;951.471933077135;960.6637676813199;4930.704157750546;4945.653804233741;5009.774560144802;5014.197728363517;5041.621878359138;5244.580433565306;5252.343457067866;5260.710660913686;5265.236540701653;5277.868053298698;4658.767061646904;4891.779869905863;4975.427825800007;4976.925346119811;4991.301217829507;2730.839393257897;2753.6144939708456;2766.585012248179;2768.6018560626753;2772.265349682336;5327.733613319396;5328.561288452096;5348.625596208306;5371.57027437804;5372.7313634318125;5092.439831618519;5185.533302002837;5270.97216042868;5284.339457567804;5319.26058080089;5304.3821634401875;5323.421857202802;5331.866703332447;5331.920550985042;5332.333833083459;5151.407588127264;5153.8403859132895;5169.715665638426;5245.636134605106;5260.789568417221;4897.2654101885;5097.515736005073;5110.795568177231;5156.278121063129;5170.663906846043;5236.717004333963;5248.763805628832;5294.729264976455;5315.15639133062;5328.440513746001;3814.6757525610633;3831.233753249417;3871.2838124945847;3873.1989624823464;3935.409688546741;5442.945570544244;5875.706214689163;5882.764689412546;5884.528867783054;5911.989923426056;5756.3380211276235;5762.7694892203845;5776.595638305278;5778.422157784188;5846.064629659404;5611.951637652309;5746.339170995389;5759.452851979056;5771.163181338767;5817.360090389969;5688.658680479184;5711.8857622848145;5724.511626976932;5731.971340143439;5743.621530832486;5608.158776183442;5813.680247586423;5849.795257166149;5857.9121313179485;5873.678422354936;5617.831465056055;5650.011248031496;5671.858203544944;5674.801381951612;5677.432256774289 03:53:45 INFO - PROCESS | 25427 | |5;yui.html;791.3827214772476;793.678560183126;854.2183901729917;866.7009881590853;911.1189153628892;15396.307166177521;16383.09892955887;16412.75380869285;16482.34070637173;16563.50309490716;12557.058220633444;14462.132272063684;14506.927465362685;14632.561023169323;14639.487617933375;857.4640849469082;858.5149390594325;862.5557837713583;863.8920134983127;864.5979619476942;852.2627926843267;854.8717692346166;855.102142750113;855.4781583234222;855.9058503564603;898.8741576179308;899.0335389456328;899.7840518275599;900.5812297281763;901.3330135699567;900.0459512916265;901.6078006067381;902.0528445132617;903.0969030969031;903.4263242840777;661.576590981772;662.4766434516725;662.787907869482;663.3731124087739;663.8738639658498;14054.297285135804;14090.577282681536;14095.78856317156;14104.85895141056;14116.294185290695;13329.600111996655;13525.458981640722;13550.390232439564;13698.863011369858;13992.93003534986;11824.645260642195;12252.571160009446;12290.631281061582;12309.569165079269;12464.439100240512;3980.2636512245326;3999.9800000999808;4042.151148258869;4062.8171732272117;4103.4460347853255;48961.75519122381;50358;55793.72103139499;69782;81811.18188818094;11449.828252576219;11664.825027624593;11777.705557361134;11997.100217483723;12020.338881361435;20277.391678249674;20338.898305508377;20339.694904576147;20364.287249946476;20386.388408347775;9288.071192880792;9308.348415610977;9341.859872101924;9363.953180234055;9536.475493847905;4966.850994470172;5049.697018178921;5099.031184075014;5129.435762066169;5202.3497062867145;3432.3306955143507;3528.647135286451;3539.911502212414;3571.1786289153642;3572.4105522588484;558.4499268220799;561.2759540193186;561.9606627536033;569.7407679505815;570.0963972104179;564.0974440894536;591.8342863998088;655.6918248423328;667.0894229376962;698.8497473043218;9651.838683259144;9665.661701840401;10048.799024019625;10168.898311016943;10553.577856885791;684.7945616315185;708.3943228539628;728.5628622826367;744.4937442539125;751.4214055177592;4627.768611569408;4803.663743537989;4826.565609095198;5389.110796718497;5445.591580631469;121038;124032;124111.37944310221;124143.379283103;124521;70589;75916;87137;103800.48099759604;108575.45712271547;61925.69037154876;85795;87688;88009.11990880137;90162;10571.524281407508;10964.945175274073;11025.283356581796;11090.44547772592;11221.551137954717;54104.72947635394;55253.44746552483;55654.72172639111;56180.15729764139;58255.70872145612;76187;78592.60703696674;78866;80078.19921800941;81529.59235203786;13449.86550134486;13982.300884955508;14225.715485690022;14271.857281427468;14316.928415357857;15136.091834489966;15533.45632902843;15689.686206275583;16058.598535036717;17141.48575542736;10693.732656683645;12939.935300323437;13332.66673332659;13341.19952802835;14005.649858753613;13725.794113088112;13916.652083697989;13935;14136.78794818099;14232.644183895485;14089.859101409265;14255.144691318139;14273.214973176575;14547;15317.77023344673;11170.106391488824;11265.7746845061;11337.886621133683;11506.153739351019;11780.70548236301;12365.134440589072;12501.43743531525;12505.812412813633;12695.492180313053;12804.551840685532 03:53:45 INFO - PROCESS | 25427 | __end_tp_report 03:53:45 INFO - PROCESS | 25427 | __start_cc_report 03:53:45 INFO - PROCESS | 25427 | _x_x_mozilla_cycle_collect,870 03:53:45 INFO - PROCESS | 25427 | __end_cc_report 03:53:45 INFO - PROCESS | 25427 | __startTimestamp1475837625068__endTimestamp 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | ------- Summary: start ------- 03:53:45 INFO - PROCESS | 25427 | Number of tests: 6 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#0] dojo.html Cycles:165 Average:5514.28 Median:5720.31 stddev:619.23 (10.8%) stddev-sans-first:592.72 03:53:45 INFO - PROCESS | 25427 | Values: 3150.7 3192.5 3211.1 3219.2 3249.9 5530.4 5619.9 5636.7 5646.6 5660.2 5483.0 5639.7 5644.6 5654.9 5671.5 5063.6 5091.1 5117.7 5141.8 5162.7 4963.6 5112.6 5156.9 5158.5 5158.8 4938.3 5005.8 5025.0 5048.6 5061.3 5055.5 5089.8 5091.4 5175.3 5198.7 4998.7 5085.4 5126.4 5142.1 5146.7 5366.8 5404.4 5418.4 5490.2 5573.0 5835.9 5858.3 5863.5 5946.4 5955.9 5995.0 5995.8 6001.1 6004.8 6009.3 5428.9 5487.6 5514.8 5567.3 5572.9 6111.1 6144.5 6153.2 6153.4 6155.2 5876.2 5905.9 5913.3 5917.7 5918.1 5781.3 5795.7 5815.4 5830.9 5845.6 5844.1 5844.3 5849.9 5853.6 5873.7 5762.4 5825.2 5826.5 5854.2 5873.7 4491.4 4528.2 4545.9 4560.7 4592.2 4090.6 4097.9 4099.4 4108.0 4132.8 5708.7 5717.1 5719.5 5720.5 5723.5 5822.9 5852.4 5889.2 6001.8 6032.0 5572.0 5632.7 5640.3 5655.9 5673.1 4979.2 4979.3 4979.5 4992.2 4997.6 5900.9 6024.2 6129.6 6164.6 6168.9 5774.4 5907.3 5927.8 6033.4 6072.0 6180.4 6199.3 6213.3 6226.8 6229.1 5751.3 5942.0 5947.4 5954.6 5963.9 5826.2 5873.3 5875.1 5878.9 5975.0 5733.4 5759.0 5760.1 5782.7 5786.1 5786.2 5787.7 5788.2 5793.9 5794.9 5558.9 5585.4 5676.9 5708.1 5720.3 5834.4 5838.7 5839.8 5840.7 5891.1 5530.9 5701.9 5708.4 5710.7 5717.5 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#1] ext.html Cycles:180 Average:49635.46 Median:37359.75 stddev:87498.42 (234.2%) stddev-sans-first:87666.38 03:53:45 INFO - PROCESS | 25427 | Values: 585.4 604.7 623.2 625.3 641.6 33945.0 37303.6 37321.1 37398.4 37402.4 47760.8 48267.8 48557.8 51689.0 51915.5 9255.3 9393.2 9403.5 9409.2 9412.0 8632.9 8786.0 9250.3 9343.2 9354.0 11110.4 11309.7 11321.5 11717.8 11722.1 11214.5 11274.6 11277.3 11317.9 11346.8 11097.1 11156.1 11166.5 11167.8 11176.1 45185.5 45227.0 45464.0 45488.0 45558.8 3406.6 3593.0 3697.8 3953.2 4461.3 34059.7 34390.1 34548.8 34678.3 34811.1 4413.8 4495.7 4500.3 4546.5 4673.9 277218.0 281053.0 281795.0 282383.0 282812.0 62536.7 62851.7 62888.7 62891.7 62988.7 39768.6 39854.4 40089.6 42974.6 42986.4 18268.0 18456.6 18457.5 18466.5 18469.6 14098.8 14192.9 14205.1 14206.1 14206.7 18028.5 18045.9 19435.7 19804.6 20015.5 7276.3 7382.7 7476.7 7559.6 7684.4 991.6 1078.2 1087.9 1119.1 1207.7 33948.8 33983.5 34291.7 34554.3 34605.3 1169.5 1205.9 1227.0 1266.5 1278.7 17978.8 18037.0 18180.8 18195.0 18198.6 161758.0 162702.0 162924.0 163079.0 163310.0 61841.7 62160.1 62445.7 62463.4 62485.7 1386.7 1429.8 1432.3 1435.6 1468.4 31723.8 33087.3 33530.9 33578.7 34011.8 53456.2 53858.2 54013.5 54081.7 54173.0 468906.0 471297.0 472034.0 472099.0 473887.0 27262.7 27533.2 28871.4 29953.7 31045.5 45432.0 49625.3 50150.5 50211.5 50355.2 42562.0 42658.4 43384.0 44153.0 44319.3 42558.0 42606.4 42983.5 43174.6 43906.3 42717.4 43578.6 43750.1 43799.3 43835.3 35963.5 38073.6 38225.2 38614.8 38772.8 28703.0 29241.9 29349.4 29482.6 29621.0 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#2] jquery.html Cycles:180 Average:31226.43 Median:3032.18 stddev:81007.50 (2671.6%) stddev-sans-first:81201.75 03:53:45 INFO - PROCESS | 25427 | Values: 429.5 429.9 437.0 437.7 447.8 19105.4 19258.3 20479.8 20561.0 20762.8 19214.0 19438.3 20566.2 20742.0 20809.7 5664.1 5929.2 5932.2 5935.8 5936.7 5741.3 5880.6 5905.3 5932.6 5951.5 5892.6 5893.5 5896.2 5896.2 5896.9 5694.4 5842.0 5870.1 5894.4 5897.7 5329.8 5336.3 5340.5 5344.2 5346.6 22595.2 23292.0 24277.9 24457.5 24619.6 3025.5 3038.9 3051.1 3065.6 3117.6 12407.8 14551.1 14866.7 15465.5 15655.4 1940.9 1989.9 2156.7 2338.8 2416.0 92492.0 93770.0 94457.5 98276.0 99967.5 18365.3 18422.6 18445.5 18601.9 18664.0 36712.4 36728.0 36803.0 36866.0 36884.0 10408.3 10500.7 10534.9 10741.5 10960.8 8890.4 8898.7 8955.6 9035.9 9225.5 9318.8 9534.2 9644.2 9671.2 9701.3 3478.8 3499.6 3597.5 3671.6 3693.7 895.7 969.2 1004.6 1006.9 1043.0 20423.8 20547.3 20572.3 20731.0 20859.4 1023.9 1033.2 1034.4 1043.6 1082.4 10567.5 11281.9 11454.7 11498.0 11563.7 461034.0 479109.0 489293.0 489405.0 524792.0 94886.5 98911.5 99770.0 104234.0 105117.0 1044.9 1098.9 1102.1 1121.9 1123.5 17670.0 18151.0 18159.7 18258.5 18588.6 43563.6 45139.5 45278.3 45741.5 46391.0 60977.7 62035.0 62197.4 62279.7 62941.4 8517.7 8762.7 8784.9 8917.0 8928.4 12359.9 13053.9 13303.5 13576.6 13582.0 11493.6 11607.4 11633.0 11869.0 12013.8 11289.9 11713.6 11767.2 12033.2 12064.7 10937.6 11980.6 12217.9 12319.4 12361.3 7598.2 7900.6 8596.1 8762.2 9130.7 10763.8 10890.8 11877.2 11905.7 12142.8 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#3] mootools.html Cycles:180 Average:6006.12 Median:4738.94 stddev:3428.63 (72.4%) stddev-sans-first:3419.98 03:53:45 INFO - PROCESS | 25427 | Values: 1297.4 1417.6 1435.4 1475.9 1862.1 7875.3 8762.9 8968.0 9091.4 9516.8 9284.1 9335.6 9339.8 9348.6 9360.1 2453.5 2481.2 2482.1 2482.5 2482.8 2411.6 2472.2 2473.0 2473.2 2478.5 2427.2 2438.3 2515.5 2516.7 2517.2 2419.2 2435.9 2441.5 2445.1 2446.6 2408.8 2434.3 2440.9 2443.7 2463.9 8939.4 9260.4 9272.7 9336.8 9363.8 5435.6 5608.1 5614.4 5617.3 5621.8 3392.9 3414.6 3450.6 3466.6 3481.5 1205.4 1254.2 1281.6 1313.9 1337.2 12753.7 12786.4 12863.0 12913.9 12927.2 4735.4 4742.5 4760.1 4883.5 4951.2 10181.7 10188.3 10189.0 10199.2 10201.7 5550.6 5566.5 5568.4 5570.9 5575.7 4573.5 4711.9 4990.3 5051.8 5196.1 4114.1 4118.6 4225.8 4270.1 4312.9 1320.2 1351.4 1352.0 1357.1 1359.3 824.7 930.9 954.6 973.3 992.6 6200.4 6205.4 6217.4 6219.3 6342.1 459.1 471.5 471.6 478.0 497.8 4240.7 4248.7 4249.4 4302.1 4360.8 11119.5 11420.6 11518.5 11526.0 11536.7 10676.3 11172.2 11186.3 11417.4 11424.5 8443.3 8666.7 8673.1 8686.0 8693.7 6035.5 6043.7 6062.1 6122.9 6468.6 10552.1 10578.8 10592.8 10704.2 10710.1 10149.1 10509.4 10513.5 10606.0 10899.7 6802.7 6998.7 7873.2 8169.3 8315.6 8651.8 9075.9 9076.2 9078.8 9086.2 7814.9 7821.5 7952.3 8069.9 8091.0 7667.7 7882.4 7904.2 7938.2 8025.9 7228.2 7282.0 7340.7 7341.4 7354.9 5202.9 5299.4 5313.7 5331.3 5406.3 5228.4 5253.7 5279.0 5282.4 5372.0 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#4] prototype.html Cycles:180 Average:4654.50 Median:5230.32 stddev:1350.92 (25.8%) stddev-sans-first:1315.04 03:53:45 INFO - PROCESS | 25427 | Values: 324.7 346.9 348.7 349.8 353.2 5531.2 5554.6 5557.8 5587.2 5607.5 5223.9 5331.9 5355.4 5380.0 5523.5 4152.3 4154.3 4301.0 4312.0 4317.8 4290.3 4305.8 4321.5 4325.5 4327.9 4059.0 4231.8 4234.2 4249.7 4281.4 4230.5 4236.1 4242.7 4247.6 4255.4 3749.8 3761.6 3769.5 3775.4 3790.4 5294.9 5363.2 5387.8 5394.7 5403.9 4904.7 4907.6 4924.1 4930.0 4941.9 5738.2 5755.4 5767.9 5769.1 5795.3 4053.3 4112.6 4145.6 4151.8 4151.9 5890.6 5957.9 5980.7 5994.5 5999.4 4154.8 4164.9 4175.9 4198.3 4204.1 4112.4 4236.4 4284.3 4294.4 4320.5 4906.7 4910.8 4925.3 4929.2 4947.5 5829.4 5838.7 5846.0 5873.2 5916.4 1435.4 1445.2 1456.3 1458.3 1460.8 936.7 940.3 940.5 951.5 960.7 4930.7 4945.7 5009.8 5014.2 5041.6 5244.6 5252.3 5260.7 5265.2 5277.9 4658.8 4891.8 4975.4 4976.9 4991.3 2730.8 2753.6 2766.6 2768.6 2772.3 5327.7 5328.6 5348.6 5371.6 5372.7 5092.4 5185.5 5271.0 5284.3 5319.3 5304.4 5323.4 5331.9 5331.9 5332.3 5151.4 5153.8 5169.7 5245.6 5260.8 4897.3 5097.5 5110.8 5156.3 5170.7 5236.7 5248.8 5294.7 5315.2 5328.4 3814.7 3831.2 3871.3 3873.2 3935.4 5442.9 5875.7 5882.8 5884.5 5912.0 5756.3 5762.8 5776.6 5778.4 5846.1 5612.0 5746.3 5759.5 5771.2 5817.4 5688.7 5711.9 5724.5 5732.0 5743.6 5608.2 5813.7 5849.8 5857.9 5873.7 5617.8 5650.0 5671.9 5674.8 5677.4 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - PROCESS | 25427 | [#5] yui.html Cycles:180 Average:20681.12 Median:3990.12 stddev:29692.76 (744.2%) stddev-sans-first:29738.49 03:53:45 INFO - PROCESS | 25427 | Values: 791.4 793.7 854.2 866.7 911.1 15396.3 16383.1 16412.8 16482.3 16563.5 12557.1 14462.1 14506.9 14632.6 14639.5 857.5 858.5 862.6 863.9 864.6 852.3 854.9 855.1 855.5 855.9 898.9 899.0 899.8 900.6 901.3 900.0 901.6 902.1 903.1 903.4 661.6 662.5 662.8 663.4 663.9 14054.3 14090.6 14095.8 14104.9 14116.3 13329.6 13525.5 13550.4 13698.9 13992.9 11824.6 12252.6 12290.6 12309.6 12464.4 3980.3 4000.0 4042.2 4062.8 4103.4 48961.8 50358.0 55793.7 69782.0 81811.2 11449.8 11664.8 11777.7 11997.1 12020.3 20277.4 20338.9 20339.7 20364.3 20386.4 9288.1 9308.3 9341.9 9364.0 9536.5 4966.9 5049.7 5099.0 5129.4 5202.3 3432.3 3528.6 3539.9 3571.2 3572.4 558.4 561.3 562.0 569.7 570.1 564.1 591.8 655.7 667.1 698.8 9651.8 9665.7 10048.8 10168.9 10553.6 684.8 708.4 728.6 744.5 751.4 4627.8 4803.7 4826.6 5389.1 5445.6 121038.0 124032.0 124111.4 124143.4 124521.0 70589.0 75916.0 87137.0 103800.5 108575.5 61925.7 85795.0 87688.0 88009.1 90162.0 10571.5 10964.9 11025.3 11090.4 11221.6 54104.7 55253.4 55654.7 56180.2 58255.7 76187.0 78592.6 78866.0 80078.2 81529.6 13449.9 13982.3 14225.7 14271.9 14316.9 15136.1 15533.5 15689.7 16058.6 17141.5 10693.7 12939.9 13332.7 13341.2 14005.6 13725.8 13916.7 13935.0 14136.8 14232.6 14089.9 14255.1 14273.2 14547.0 15317.8 11170.1 11265.8 11337.9 11506.2 11780.7 12365.1 12501.4 12505.8 12695.5 12804.6 03:53:45 INFO - PROCESS | 25427 | -------- Summary: end -------- 03:53:45 INFO - PROCESS | 25427 | 03:53:45 INFO - TEST-INFO | 25427: exit 0 03:53:45 INFO - TEST-OK | dromaeo_css | took 1113766ms 03:53:45 INFO - TEST-START | kraken 03:53:45 INFO - operating with platform_type : linux_ 03:53:45 INFO - Initialising browser for kraken test... 03:53:45 INFO - TEST-INFO | started process 25744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSroklW/profile http://localhost:52196/getInfo.html) 03:53:50 INFO - PROCESS | 25744 | __metrics Screen width/height:1600/1200 03:53:50 INFO - PROCESS | 25744 | colorDepth:24 03:53:50 INFO - PROCESS | 25744 | Browser inner width/height: 1024/697 03:53:50 INFO - PROCESS | 25744 | __metrics 03:53:50 INFO - PROCESS | 25744 | 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:53:50 INFO - PROCESS | 25744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:51 INFO - PROCESS | 25744 | console.error: PushService: 03:53:51 INFO - PROCESS | 25744 | stateChangeProcessEnqueue: Error transitioning state 03:53:51 INFO - PROCESS | 25744 | UnknownError 03:53:51 INFO - TEST-INFO | 25744: exit 0 03:53:51 INFO - Browser initialized. 03:53:51 INFO - Running cycle 1/1 for kraken test... 03:53:51 INFO - TEST-INFO | started process 25837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSroklW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:03 INFO - PROCESS | 25837 | RSS: Main: 145047552 03:54:03 INFO - PROCESS | 25837 | 03:54:06 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52196/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:06 INFO - PROCESS | 25837 | RSS: Main: 185954304 03:54:06 INFO - PROCESS | 25837 | 03:54:09 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52196/tests/kraken/driver.html?testName=audio-dft) 03:54:10 INFO - PROCESS | 25837 | RSS: Main: 175333376 03:54:10 INFO - PROCESS | 25837 | 03:54:12 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52196/tests/kraken/driver.html?testName=audio-fft) 03:54:13 INFO - PROCESS | 25837 | RSS: Main: 266510336 03:54:13 INFO - PROCESS | 25837 | 03:54:15 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52196/tests/kraken/driver.html?testName=audio-oscillator) 03:54:16 INFO - PROCESS | 25837 | RSS: Main: 173547520 03:54:16 INFO - PROCESS | 25837 | 03:54:18 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:18 INFO - PROCESS | 25837 | RSS: Main: 175497216 03:54:18 INFO - PROCESS | 25837 | 03:54:21 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52196/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:22 INFO - PROCESS | 25837 | RSS: Main: 210817024 03:54:22 INFO - PROCESS | 25837 | 03:54:25 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52196/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:26 INFO - PROCESS | 25837 | RSS: Main: 209383424 03:54:26 INFO - PROCESS | 25837 | 03:54:29 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52196/tests/kraken/driver.html?testName=json-parse-financial) 03:54:29 INFO - PROCESS | 25837 | RSS: Main: 209973248 03:54:29 INFO - PROCESS | 25837 | 03:54:31 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:31 INFO - PROCESS | 25837 | RSS: Main: 172290048 03:54:31 INFO - PROCESS | 25837 | 03:54:33 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:34 INFO - PROCESS | 25837 | RSS: Main: 179507200 03:54:34 INFO - PROCESS | 25837 | 03:54:36 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:36 INFO - PROCESS | 25837 | RSS: Main: 189186048 03:54:36 INFO - PROCESS | 25837 | 03:54:39 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:39 INFO - PROCESS | 25837 | RSS: Main: 197316608 03:54:39 INFO - PROCESS | 25837 | 03:54:42 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:43 INFO - PROCESS | 25837 | RSS: Main: 194109440 03:54:43 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | Cycle 1(1): loaded http://localhost:52196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52196/tests/kraken/driver.html?testName=ai-astar) 03:54:44 INFO - PROCESS | 25837 | RSS: Main: 244772864 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | __start_tp_report 03:54:44 INFO - PROCESS | 25837 | _x_x_mozilla_page_load 03:54:44 INFO - PROCESS | 25837 | _x_x_mozilla_page_load_details 03:54:44 INFO - PROCESS | 25837 | |i|pagename|runs| 03:54:44 INFO - PROCESS | 25837 | |0;ai-astar;112;115;124;115;113;115;113;114;115;113 03:54:44 INFO - PROCESS | 25837 | |1;audio-beat-detection;144;122;117;165;118;118;118;121;150;117 03:54:44 INFO - PROCESS | 25837 | |2;audio-dft;160;161;162;161;160;160;160;159;158;159 03:54:44 INFO - PROCESS | 25837 | |3;audio-fft;77;77;76;112;76;76;75;77;103;76 03:54:44 INFO - PROCESS | 25837 | |4;audio-oscillator;83;81;108;81;82;81;100;80;82;114 03:54:44 INFO - PROCESS | 25837 | |5;imaging-gaussian-blur;118;117;117;117;116;116;117;117;117;117 03:54:44 INFO - PROCESS | 25837 | |6;imaging-darkroom;146;146;145;145;146;146;145;181;145;146 03:54:44 INFO - PROCESS | 25837 | |7;imaging-desaturate;94;95;95;94;95;95;94;95;95;95 03:54:44 INFO - PROCESS | 25837 | |8;json-parse-financial;51;51;50;50;50;53;49;59;50;51 03:54:44 INFO - PROCESS | 25837 | |9;json-stringify-tinderbox;59;59;65;60;58;58;58;59;59;66 03:54:44 INFO - PROCESS | 25837 | |10;stanford-crypto-aes;83;76;73;73;79;77;74;73;76;74 03:54:44 INFO - PROCESS | 25837 | |11;stanford-crypto-ccm;130;120;120;121;122;128;116;122;153;128 03:54:44 INFO - PROCESS | 25837 | |12;stanford-crypto-pbkdf2;153;153;152;153;154;154;160;158;152;155 03:54:44 INFO - PROCESS | 25837 | |13;stanford-crypto-sha256-iterative;64;63;63;62;62;63;62;62;61;66 03:54:44 INFO - PROCESS | 25837 | __end_tp_report 03:54:44 INFO - PROCESS | 25837 | __start_cc_report 03:54:44 INFO - PROCESS | 25837 | _x_x_mozilla_cycle_collect,1599 03:54:44 INFO - PROCESS | 25837 | __end_cc_report 03:54:44 INFO - PROCESS | 25837 | __startTimestamp1475837684985__endTimestamp 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | ------- Summary: start ------- 03:54:44 INFO - PROCESS | 25837 | Number of tests: 14 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:3.38 (2.9%) stddev-sans-first:3.42 03:54:44 INFO - PROCESS | 25837 | Values: 112.0 115.0 124.0 115.0 113.0 115.0 113.0 114.0 115.0 113.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:121.50 stddev:17.40 (14.3%) stddev-sans-first:17.59 03:54:44 INFO - PROCESS | 25837 | Values: 144.0 122.0 117.0 165.0 118.0 118.0 118.0 121.0 150.0 117.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 03:54:44 INFO - PROCESS | 25837 | Values: 160.0 161.0 162.0 161.0 160.0 160.0 160.0 159.0 158.0 159.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.36 (17.6%) stddev-sans-first:14.02 03:54:44 INFO - PROCESS | 25837 | Values: 77.0 77.0 76.0 112.0 76.0 76.0 75.0 77.0 103.0 76.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.00 stddev:12.97 (16.0%) stddev-sans-first:13.56 03:54:44 INFO - PROCESS | 25837 | Values: 83.0 81.0 108.0 81.0 82.0 81.0 100.0 80.0 82.0 114.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 03:54:44 INFO - PROCESS | 25837 | Values: 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:146.00 stddev:11.22 (7.7%) stddev-sans-first:11.84 03:54:44 INFO - PROCESS | 25837 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 181.0 145.0 146.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:54:44 INFO - PROCESS | 25837 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:2.88 (5.6%) stddev-sans-first:3.05 03:54:44 INFO - PROCESS | 25837 | Values: 51.0 51.0 50.0 50.0 50.0 53.0 49.0 59.0 50.0 51.0 03:54:44 INFO - PROCESS | 25837 | 03:54:44 INFO - PROCESS | 25837 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.00 stddev:2.92 (5.0%) stddev-sans-first:3.07 03:54:44 INFO - PROCESS | 25837 | Values: 59.0 59.0 65.0 60.0 58.0 58.0 58.0 59.0 59.0 66.0 03:54:45 INFO - PROCESS | 25837 | 03:54:45 INFO - PROCESS | 25837 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:3.22 (4.2%) stddev-sans-first:2.12 03:54:45 INFO - PROCESS | 25837 | Values: 83.0 76.0 73.0 73.0 79.0 77.0 74.0 73.0 76.0 74.0 03:54:45 INFO - PROCESS | 25837 | 03:54:45 INFO - PROCESS | 25837 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.00 stddev:10.45 (8.4%) stddev-sans-first:10.98 03:54:45 INFO - PROCESS | 25837 | Values: 130.0 120.0 120.0 121.0 122.0 128.0 116.0 122.0 153.0 128.0 03:54:45 INFO - PROCESS | 25837 | 03:54:45 INFO - PROCESS | 25837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.00 stddev:2.63 (1.7%) stddev-sans-first:2.74 03:54:45 INFO - PROCESS | 25837 | Values: 153.0 153.0 152.0 153.0 154.0 154.0 160.0 158.0 152.0 155.0 03:54:45 INFO - PROCESS | 25837 | 03:54:45 INFO - PROCESS | 25837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.40 (2.2%) stddev-sans-first:1.41 03:54:45 INFO - PROCESS | 25837 | Values: 64.0 63.0 63.0 62.0 62.0 63.0 62.0 62.0 61.0 66.0 03:54:45 INFO - PROCESS | 25837 | -------- Summary: end -------- 03:54:45 INFO - PROCESS | 25837 | 03:54:45 INFO - TEST-INFO | 25837: exit 0 03:54:46 INFO - TEST-OK | kraken | took 60172ms 03:54:46 INFO - SUITE-END | took 1173s 03:54:46 INFO - Completed test suite (00:19:34) 03:54:46 INFO - javascript benchmark 03:54:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.684931506849, 3192.4892017277234, 3211.100891750311, 3219.1791093271213, 3249.870005199792, 5530.4193059728705, 5619.887602247958, 5636.689982050985, 5646.632968857021, 5660.2358681577925, 5483.0, 5639.718014099289, 5644.604877658566, 5654.915176272349, 5671.461211184941, 5063.645544811865, 5091.1090559152, 5117.744112794364, 5141.794328226866, 5162.741862906859, 4963.6277279204205, 5112.565431938289, 5156.92264616031, 5158.484151584849, 5158.793648254065, 4938.308636790852, 5005.774740136702, 5025.020121076392, 5048.596112311025, 5061.316722242487, 5055.545000949914, 5089.770960306795, 5091.363579552556, 5175.301334319856, 5198.740062996835, 4998.650094493387, 5085.389753229599, 5126.384833819928, 5142.125838607446, 5146.742662866842, 5366.838994830161, 5404.351477822647, 5418.376886658046, 5490.203920431555, 5573.024720673866, 5835.941640583625, 5858.2677165354335, 5863.472287494146, 5946.405359464062, 5955.940440595626, 5994.97002514989, 5995.760169593211, 6001.129836173774, 6004.78983235589, 6009.278886533601, 5428.945710542923, 5487.5609951203805, 5514.834554963398, 5567.331920169525, 5572.888542229132, 6111.083337499322, 6144.539159563051, 6153.2000839890525, 6153.446189842935, 6155.230596175478, 5876.1773351729935, 5905.881882362329, 5913.29040515141, 5917.733701983421, 5918.082697181943, 5781.335146458127, 5795.739191736382, 5815.389384114692, 5830.912536311958, 5845.649261044351, 5844.064949608042, 5844.298684157929, 5849.912251316234, 5853.64878107315, 5873.735681894325, 5762.423757624204, 5825.242718446575, 5826.504747096459, 5854.2389489366105, 5873.735681894325, 4491.438570178728, 4528.230200865861, 4545.931811022837, 4560.749158796231, 4592.196365636067, 4090.5909409058854, 4097.85657501986, 4099.405586190045, 4108.0, 4132.793360331972, 5708.686022268815, 5717.085266357363, 5719.542436605145, 5720.48515633595, 5723.456271654186, 5822.94177058224, 5852.4440178183, 5889.234399528034, 6001.819945401645, 6032.034874420072, 5572.0, 5632.662040277596, 5640.294963129609, 5655.915161272585, 5673.092305231144, 4979.178435558092, 4979.3277907482025, 4979.4771548987555, 4992.151334273182, 4997.600191984632, 5900.881982360243, 6024.246969128859, 6129.601575897553, 6164.630122192593, 6168.907466388007, 5774.3648198697265, 5907.261592300963, 5927.8221653350465, 6033.42682445167, 6072.028475443908, 6180.3848182912825, 6199.28708198563, 6213.316535181036, 6226.813195604139, 6229.096780966644, 5751.252337196138, 5942.0, 5947.405259474018, 5954.553408494294, 5963.850903727268, 5826.184334193301, 5873.324567674772, 5875.118732190205, 5878.882422351615, 5975.043992961106, 5733.4266573344, 5758.971205143947, 5760.0783874579865, 5782.681952492653, 5786.132080188006, 5786.247787787561, 5787.652740835563, 5788.160716696139, 5793.8551536211935, 5794.855128621818, 5558.944410555842, 5585.385607583082, 5676.886462270649, 5708.115242137475, 5720.313562372376, 5834.416558344302, 5838.737256823369, 5839.766409343579, 5840.737166827418, 5891.1457838612305, 5530.944690553204, 5701.945140149086, 5708.372079071216, 5710.685912274865, 5717.514011308919], "value": 5472.832570137801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.3794977324037, 604.655346452522, 623.2023010546496, 625.334019269478, 641.6022066318882, 33945.0, 37303.626963730356, 37321.06697332564, 37398.439023414605, 37402.43896341554, 47760.76119619406, 48267.75866120673, 48557.757211213895, 51689.0, 51915.48084519154, 9255.259579233645, 9393.20157786589, 9403.482808445533, 9409.153176214139, 9411.95294023529, 8632.870506942401, 8785.956070219672, 9250.25997920168, 9343.159115679588, 9353.95323023384, 11110.44447777612, 11309.717257068556, 11321.547138114507, 11717.824232636518, 11722.120840936965, 11214.495347709331, 11274.605388811353, 11277.266977646426, 11317.886821131808, 11346.829797553044, 11097.1122310215, 11156.10751139915, 11166.497507612177, 11167.83248251277, 11176.05003574689, 45185.54814451879, 45227.0, 45464.0, 45488.0, 45558.772206138754, 3406.6252712201886, 3592.982035089834, 3697.759645623026, 3953.2488827122756, 4461.286194208911, 34059.659403405894, 34390.140246493786, 34548.82725586381, 34678.30643387143, 34811.12972175691, 4413.823447062114, 4495.662825288084, 4500.347449619787, 4546.47715512717, 4673.924997250651, 277218.0, 281053.0, 281795.0, 282383.0, 282812.0, 62536.687316563126, 62851.685741571, 62888.68555657192, 62891.685541572915, 62988.685056574424, 39768.60231397649, 39854.402183967264, 40089.59910400917, 42974.57025429768, 42986.355204671956, 18268.0, 18456.630867382846, 18457.5385615358, 18466.538336541424, 18469.630607388044, 14098.788518172236, 14192.85807141936, 14205.147691138565, 14206.147631142165, 14206.715865682629, 18028.54928626795, 18045.909770451064, 19435.705566527307, 19804.603907921763, 20015.498062742157, 7276.308750668678, 7382.741604043833, 7476.663550140257, 7559.5809341011445, 7684.423668224794, 991.6430085169334, 1078.2021304234809, 1087.853139826129, 1119.1270808769173, 1207.722223888493, 33948.830255849054, 33983.49024764581, 34291.65708342884, 34554.30891382158, 34605.307893841986, 1169.5264515549552, 1205.8552973643043, 1227.0, 1266.4807428954084, 1278.7186818899827, 17978.820211797974, 18037.0, 18180.81819181791, 18195.0, 18198.63602727938, 161758.0, 162702.0, 162924.0, 163079.0, 163310.0, 61841.690791545756, 62160.067598986054, 62445.68777156085, 62463.37536624575, 62485.68757156185, 1386.7018591002982, 1429.7926800614061, 1432.3196481671123, 1435.5836807325759, 1468.4419920430169, 31723.84138079295, 33087.33825323432, 33530.93958800118, 33578.664213358534, 34011.82994085113, 53456.198157028455, 53858.19212711734, 54013.459865400844, 54081.72959135179, 54173.0, 468906.0, 471297.0, 472034.0, 472099.0, 473887.0, 27262.727372726018, 27533.17400477989, 28871.422571548872, 29953.70046299509, 31045.534316984813, 45432.0, 49625.255621166434, 50150.49849501458, 50211.497885022145, 50355.24467132923, 42562.0, 42658.360124598774, 43384.0, 44153.0, 44319.33520997123, 42558.0, 42606.360904587076, 42983.495577654634, 43174.568254317055, 43906.34140487959, 42717.35923961205, 43578.56421435872, 43750.124997500505, 43799.34300985424, 43835.342469863615, 35963.46054809232, 38073.61926380811, 38225.23549529049, 38614.80692596519, 38772.80613596914, 28703.0, 29241.85379073091, 29349.41301173922, 29482.557761633165, 29621.0], "value": 20370.503305284295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.4952459151796, 429.93550967354895, 436.99563004369946, 437.71548493479247, 447.76492341520697, 19105.42683719487, 19258.325958591453, 20479.795202047975, 20561.0, 20762.792372076274, 19214.0, 19438.319658811943, 20566.177352905866, 20742.0, 20809.687854682194, 5664.122061080539, 5929.1995580596495, 5932.169496270526, 5935.821925342247, 5936.673482958436, 5741.311042674884, 5880.5883588148845, 5905.261842269716, 5932.6143800653035, 5951.464368206861, 5892.616979896293, 5893.528517718593, 5896.174535565003, 5896.174535565025, 5896.941030589682, 5694.402087780785, 5842.0, 5870.11948207768, 5894.3810899855325, 5897.734601942923, 5329.760160792774, 5336.252924590561, 5340.465953404668, 5344.22508736235, 5346.625736198468, 22595.20916767905, 23292.0, 24277.87861060701, 24457.510849783084, 24619.63070553943, 3025.4554180247546, 3038.9088327349996, 3051.0694238257324, 3065.6167979002626, 3117.563541104247, 12407.813882791765, 14551.126932383984, 14866.702665946621, 15465.458708945132, 15655.373785048585, 1940.922363105474, 1989.9303524376721, 2156.7196264485674, 2338.8128949683983, 2415.975840241593, 92492.0, 93770.0, 94457.52771236168, 98276.0, 99967.50016249945, 18365.265389384276, 18422.631547369245, 18445.5388615283, 18601.883886966825, 18664.04027577112, 36712.449313260324, 36728.0, 36803.0, 36866.0, 36884.0, 10408.271421000609, 10500.684979450629, 10534.946505349557, 10741.462926853626, 10960.780784384428, 8890.422122562013, 8898.688545900863, 8955.552222388855, 9035.870516185476, 9225.49259790718, 9318.767030824283, 9534.18959388446, 9644.228461723045, 9671.226301895831, 9701.320907536405, 3478.843452044664, 3499.600159936046, 3597.5323207982797, 3671.6231413220044, 3693.7414380993073, 895.6641259527677, 969.2052516936186, 1004.5630150884389, 1006.8741407324085, 1042.9634962776267, 20423.753387127403, 20547.253483454075, 20572.279970200972, 20731.0, 20859.37421877346, 1023.902729240721, 1033.204432586919, 1034.384541197986, 1043.5929987304958, 1082.426314053553, 10567.524461399256, 11281.887181128248, 11454.656360309038, 11498.0, 11563.6530904073, 461034.0, 479109.0, 489293.0, 489405.0, 524792.0, 94886.52556737172, 98911.50544247232, 99770.0, 104234.0, 105117.0, 1044.8902865199198, 1098.8626421697288, 1102.079763397556, 1121.9214654974237, 1123.4607388453587, 17670.0, 18151.0, 18159.727604086213, 18258.45224643263, 18588.628227435645, 43563.56436435722, 45139.54860451485, 45278.32082518699, 45741.542584573726, 46391.0, 60977.695111525936, 62035.0, 62197.37802621916, 62279.6886015567, 62941.37058629355, 8517.659293628185, 8762.693305734269, 8784.91215087841, 8917.019127896056, 8928.375013749235, 12359.876401235873, 13053.934730326668, 13303.534376296782, 13576.59270221895, 13582.049256551947, 11493.597724079951, 11607.36159511235, 11633.0, 11869.0, 12013.819792702941, 11289.887101128883, 11713.590024349107, 11767.176297659424, 12033.217840840318, 12064.705561965016, 10937.56249750001, 11980.64058078259, 12217.877821221675, 12319.384030798245, 12361.320127393079, 7598.240175982579, 7900.604969751605, 8596.054434012378, 8762.211400973943, 9130.680426185052, 10763.784724305626, 10890.782184356427, 11877.22798018126, 11905.702357441134, 12142.75714485723], "value": 10545.474421210774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.351324337831, 1417.5959851442342, 1435.3540906592034, 1475.9262036898153, 1862.1341076399472, 7875.251851074146, 8762.86855697165, 8967.955160224197, 9091.363604547667, 9516.76208094798, 9284.071592840712, 9335.62657493701, 9339.76650583734, 9348.626054957793, 9360.110789475006, 2453.521563295158, 2481.2308184462872, 2482.056818409002, 2482.5283196192668, 2482.7765501104896, 2411.5779738545684, 2472.196536125766, 2472.9629055564183, 2473.208573256559, 2478.4881222454287, 2427.174760581402, 2438.317271164077, 2515.4843257132243, 2516.660250866137, 2517.244826552036, 2419.1653879411574, 2435.9391015224674, 2441.4750828571764, 2445.119756887519, 2446.584080706284, 2408.759124087577, 2434.318390850565, 2440.877956102188, 2443.68232129822, 2463.864487453189, 8939.41893776909, 9260.351775375726, 9272.675456359062, 9336.766580835465, 9363.76590585234, 5435.592330575183, 5608.074667679828, 5614.354349249807, 5617.325920889479, 5621.831345059655, 3392.8982130536124, 3414.556107706007, 3450.603180634234, 3466.5666791651042, 3481.5125882376487, 1205.439470646145, 1254.1534464236695, 1281.592751549836, 1313.9145955512956, 1337.224409842289, 12753.744925101446, 12786.360681965958, 12863.0, 12913.870861291362, 12927.15973461722, 4735.360726301974, 4742.511888444097, 4760.071786001697, 4883.51164883516, 4951.207806750903, 10181.74545636365, 10188.286819922534, 10189.0, 10199.235057370726, 10201.74495637615, 5550.611457198038, 5566.471185237396, 5568.44315568448, 5570.944290557042, 5575.749091290902, 4573.49691533931, 4711.905761884743, 4990.30135780991, 5051.823186188466, 5196.1166601677805, 4114.136031433432, 4118.608732170439, 4225.809838557272, 4270.10327831159, 4312.913741725148, 1320.1682939748089, 1351.3783659516537, 1351.9797203041962, 1357.0771875124813, 1359.306753555674, 824.698984870518, 930.8603709443502, 954.6420092465326, 973.3235401396104, 992.6029588164647, 6200.3799620037635, 6205.410486003822, 6217.378262173836, 6219.284782250099, 6342.143810585604, 459.0635104387013, 471.49785478465327, 471.58029353875077, 477.9928301075487, 497.8282492540068, 4240.724352917112, 4248.745075295492, 4249.426327445755, 4302.118065796504, 4360.803763830635, 11119.499622517005, 11420.600278990196, 11518.481668324945, 11526.0, 11536.711582210512, 10676.252662313564, 11172.162087843282, 11186.32882027081, 11417.37204453763, 11424.543018279343, 8443.282321002784, 8666.696665616799, 8673.132686731402, 8686.0, 8693.739187824376, 6035.486983606443, 6043.697815109139, 6062.090686397076, 6122.938770612237, 6468.644224567505, 10552.050315471644, 10578.841317380091, 10592.841107383241, 10704.197185211297, 10710.089642380484, 10149.137323327599, 10509.369437833755, 10513.474326283807, 10606.045455909005, 10899.673009809718, 6802.659867006729, 6998.685059172248, 7873.212678732081, 8169.305609023299, 8315.584220788814, 8651.826963460822, 9075.863862042206, 9076.228520575562, 9078.818423631623, 9086.22767064807, 7814.882776758467, 7821.491603045783, 7952.324052455606, 8069.87895181561, 8091.029076510857, 7667.731629392944, 7882.408819338687, 7904.170062143392, 7938.24586664266, 8025.919740802751, 7228.241034691492, 7282.0, 7340.743073992385, 7341.375983041501, 7354.926450735638, 5202.869928251824, 5299.364076310867, 5313.734313284398, 5331.253624492651, 5406.268079079095, 5228.372595288438, 5253.711045892513, 5279.0, 5282.418933917189, 5372.0], "value": 4729.37914308076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.7027281979992, 346.9150058235732, 348.65483171660065, 349.8145982629206, 353.2405328543629, 5531.197976293435, 5554.638948468347, 5557.833265002051, 5587.245721827552, 5607.495325420711, 5223.921641175385, 5331.893362132755, 5355.410904800478, 5379.9731001344935, 5523.475269849358, 4152.335626299792, 4154.335306350992, 4300.956990430087, 4311.9784401078105, 4317.805698743564, 4290.2706539888295, 4305.784710764449, 4321.481422229337, 4325.52419233884, 4327.935080973788, 4058.9594104059024, 4231.76725280111, 4234.237837189305, 4249.723767955088, 4281.422008028923, 4230.51349094855, 4236.089240813225, 4242.748389225155, 4247.596478334538, 4255.361695745632, 3749.7562658427387, 3761.586225515191, 3769.4534292527705, 3775.3959366501504, 3790.3556395412847, 5294.867628309285, 5363.195520671891, 5387.757550910218, 5394.651337165708, 5403.918941215846, 4904.7383489979475, 4907.558319751204, 4924.079608952511, 4929.975350123263, 4941.925871111936, 5738.225339579145, 5755.366909639936, 5767.8558036049435, 5769.14427358456, 5795.275590551181, 4053.27041132596, 4112.629863312286, 4145.585441455861, 4151.813168407429, 4151.858238984273, 5890.646561206384, 5957.91063134049, 5980.730867110947, 5994.490468310199, 5999.430054144849, 4154.774341569244, 4164.8542301019315, 4175.935136540163, 4198.28629133042, 4204.1171354016, 4112.383142528644, 4236.385724069993, 4284.250256205151, 4294.398784170218, 4320.4599425071865, 4906.705597664151, 4910.8281210157475, 4925.335079764258, 4929.186684197068, 4947.505249475095, 5829.446202610745, 5838.678872662044, 5846.0061789495885, 5873.177755114288, 5916.408359164136, 1435.4473527691914, 1445.1906932118047, 1456.2936975566843, 1458.3145921416917, 1460.8466111058399, 936.681528280388, 940.2584735430382, 940.5156344482597, 951.471933077135, 960.6637676813199, 4930.704157750546, 4945.653804233741, 5009.774560144802, 5014.197728363517, 5041.621878359138, 5244.580433565306, 5252.343457067866, 5260.710660913686, 5265.236540701653, 5277.868053298698, 4658.767061646904, 4891.779869905863, 4975.427825800007, 4976.925346119811, 4991.301217829507, 2730.839393257897, 2753.6144939708456, 2766.585012248179, 2768.6018560626753, 2772.265349682336, 5327.733613319396, 5328.561288452096, 5348.625596208306, 5371.57027437804, 5372.7313634318125, 5092.439831618519, 5185.533302002837, 5270.97216042868, 5284.339457567804, 5319.26058080089, 5304.3821634401875, 5323.421857202802, 5331.866703332447, 5331.920550985042, 5332.333833083459, 5151.407588127264, 5153.8403859132895, 5169.715665638426, 5245.636134605106, 5260.789568417221, 4897.2654101885, 5097.515736005073, 5110.795568177231, 5156.278121063129, 5170.663906846043, 5236.717004333963, 5248.763805628832, 5294.729264976455, 5315.15639133062, 5328.440513746001, 3814.6757525610633, 3831.233753249417, 3871.2838124945847, 3873.1989624823464, 3935.409688546741, 5442.945570544244, 5875.706214689163, 5882.764689412546, 5884.528867783054, 5911.989923426056, 5756.3380211276235, 5762.7694892203845, 5776.595638305278, 5778.422157784188, 5846.064629659404, 5611.951637652309, 5746.339170995389, 5759.452851979056, 5771.163181338767, 5817.360090389969, 5688.658680479184, 5711.8857622848145, 5724.511626976932, 5731.971340143439, 5743.621530832486, 5608.158776183442, 5813.680247586423, 5849.795257166149, 5857.9121313179485, 5873.678422354936, 5617.831465056055, 5650.011248031496, 5671.858203544944, 5674.801381951612, 5677.432256774289], "value": 4227.607884580259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.3827214772476, 793.678560183126, 854.2183901729917, 866.7009881590853, 911.1189153628892, 15396.307166177521, 16383.09892955887, 16412.75380869285, 16482.34070637173, 16563.50309490716, 12557.058220633444, 14462.132272063684, 14506.927465362685, 14632.561023169323, 14639.487617933375, 857.4640849469082, 858.5149390594325, 862.5557837713583, 863.8920134983127, 864.5979619476942, 852.2627926843267, 854.8717692346166, 855.102142750113, 855.4781583234222, 855.9058503564603, 898.8741576179308, 899.0335389456328, 899.7840518275599, 900.5812297281763, 901.3330135699567, 900.0459512916265, 901.6078006067381, 902.0528445132617, 903.0969030969031, 903.4263242840777, 661.576590981772, 662.4766434516725, 662.787907869482, 663.3731124087739, 663.8738639658498, 14054.297285135804, 14090.577282681536, 14095.78856317156, 14104.85895141056, 14116.294185290695, 13329.600111996655, 13525.458981640722, 13550.390232439564, 13698.863011369858, 13992.93003534986, 11824.645260642195, 12252.571160009446, 12290.631281061582, 12309.569165079269, 12464.439100240512, 3980.2636512245326, 3999.9800000999808, 4042.151148258869, 4062.8171732272117, 4103.4460347853255, 48961.75519122381, 50358.0, 55793.72103139499, 69782.0, 81811.18188818094, 11449.828252576219, 11664.825027624593, 11777.705557361134, 11997.100217483723, 12020.338881361435, 20277.391678249674, 20338.898305508377, 20339.694904576147, 20364.287249946476, 20386.388408347775, 9288.071192880792, 9308.348415610977, 9341.859872101924, 9363.953180234055, 9536.475493847905, 4966.850994470172, 5049.697018178921, 5099.031184075014, 5129.435762066169, 5202.3497062867145, 3432.3306955143507, 3528.647135286451, 3539.911502212414, 3571.1786289153642, 3572.4105522588484, 558.4499268220799, 561.2759540193186, 561.9606627536033, 569.7407679505815, 570.0963972104179, 564.0974440894536, 591.8342863998088, 655.6918248423328, 667.0894229376962, 698.8497473043218, 9651.838683259144, 9665.661701840401, 10048.799024019625, 10168.898311016943, 10553.577856885791, 684.7945616315185, 708.3943228539628, 728.5628622826367, 744.4937442539125, 751.4214055177592, 4627.768611569408, 4803.663743537989, 4826.565609095198, 5389.110796718497, 5445.591580631469, 121038.0, 124032.0, 124111.37944310221, 124143.379283103, 124521.0, 70589.0, 75916.0, 87137.0, 103800.48099759604, 108575.45712271547, 61925.69037154876, 85795.0, 87688.0, 88009.11990880137, 90162.0, 10571.524281407508, 10964.945175274073, 11025.283356581796, 11090.44547772592, 11221.551137954717, 54104.72947635394, 55253.44746552483, 55654.72172639111, 56180.15729764139, 58255.70872145612, 76187.0, 78592.60703696674, 78866.0, 80078.19921800941, 81529.59235203786, 13449.86550134486, 13982.300884955508, 14225.715485690022, 14271.857281427468, 14316.928415357857, 15136.091834489966, 15533.45632902843, 15689.686206275583, 16058.598535036717, 17141.48575542736, 10693.732656683645, 12939.935300323437, 13332.66673332659, 13341.19952802835, 14005.649858753613, 13725.794113088112, 13916.652083697989, 13935.0, 14136.78794818099, 14232.644183895485, 14089.859101409265, 14255.144691318139, 14273.214973176575, 14547.0, 15317.77023344673, 11170.106391488824, 11265.7746845061, 11337.886621133683, 11506.153739351019, 11780.70548236301, 12365.134440589072, 12501.43743531525, 12505.812412813633, 12695.492180313053, 12804.551840685532], "value": 7714.683839422835, "unit": "score"}], "name": "dromaeo_css", "value": 7523.568733211367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 124.0, 115.0, 113.0, 115.0, 113.0, 114.0, 115.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 117.0, 165.0, 118.0, 118.0, 118.0, 121.0, 150.0, 117.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 160.0, 160.0, 160.0, 159.0, 158.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 112.0, 76.0, 76.0, 75.0, 77.0, 103.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 108.0, 81.0, 82.0, 81.0, 100.0, 80.0, 82.0, 114.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 181.0, 145.0, 146.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 50.0, 53.0, 49.0, 59.0, 50.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 65.0, 60.0, 58.0, 58.0, 58.0, 59.0, 59.0, 66.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 73.0, 73.0, 79.0, 77.0, 74.0, 73.0, 76.0, 74.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 120.0, 121.0, 122.0, 128.0, 116.0, 122.0, 153.0, 128.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 152.0, 153.0, 154.0, 154.0, 160.0, 158.0, 152.0, 155.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 66.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1466.8, "alertThreshold": 2.0}]} 03:54:46 INFO - Return code: 0 03:54:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:46 INFO - # TBPL SUCCESS # 03:54:46 INFO - Running post-action listener: _resource_record_post_action 03:54:46 INFO - [mozharness: 2016-10-07 10:54:46.308654Z] Finished run-tests step (success) 03:54:46 INFO - Running post-run listener: _resource_record_post_run 03:54:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1994752; Write bytes: 368578560; Read time: 56; Write time: 292552 03:54:46 INFO - TinderboxPrint: CPU usage
13.0% 03:54:46 INFO - TinderboxPrint: I/O read bytes / time
1,994,752 / 56 03:54:46 INFO - TinderboxPrint: I/O write bytes / time
368,578,560 / 292,552 03:54:46 INFO - TinderboxPrint: CPU idle
8,259.8 (87.0%) 03:54:46 INFO - TinderboxPrint: CPU user
1,190.4 (12.5%) 03:54:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118751232; Read time: 0; Write time: 95892 03:54:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249827328; Read time: 24; Write time: 196660 03:54:46 INFO - Running post-run listener: _upload_blobber_files 03:54:46 INFO - Blob upload gear active. 03:54:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:50 INFO - (blobuploader) - INFO - Done attempting. 03:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:51 INFO - (blobuploader) - INFO - Done attempting. 03:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:52 INFO - (blobuploader) - INFO - Done attempting. 03:54:52 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:52 INFO - Return code: 0 03:54:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a08bd159aa0bebe27c385b094d85f8d015042e6ea034ebeb49378c7f6c56e05813c1b14d9c9582afe1bdb908eed044cb2bf6754ad60b7f737b517aa70d809d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0b9e7b22b55bb1af92c39aa02edd573354f140399713a1258048bb3b026aaf230d039e5605c6939aaae38290ea4677c29a0e3f6d54a0d484d39c323fbb7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4157358a2ca6e01a0946875f104f4bdda516073d4790fabeba92d285738f66c04834cd168e1a12ab9c4ca60338c4c35ef78e255fbfbdbfaef8e42db3f15f952"} 03:54:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:52 INFO - Contents: 03:54:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a08bd159aa0bebe27c385b094d85f8d015042e6ea034ebeb49378c7f6c56e05813c1b14d9c9582afe1bdb908eed044cb2bf6754ad60b7f737b517aa70d809d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0b9e7b22b55bb1af92c39aa02edd573354f140399713a1258048bb3b026aaf230d039e5605c6939aaae38290ea4677c29a0e3f6d54a0d484d39c323fbb7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4157358a2ca6e01a0946875f104f4bdda516073d4790fabeba92d285738f66c04834cd168e1a12ab9c4ca60338c4c35ef78e255fbfbdbfaef8e42db3f15f952"} 03:54:52 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:52 INFO - Copying logs to upload dir... 03:54:52 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.357159 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-07 03:54:51.967147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 03:54:51.971010) ========= 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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 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/a08bd159aa0bebe27c385b094d85f8d015042e6ea034ebeb49378c7f6c56e05813c1b14d9c9582afe1bdb908eed044cb2bf6754ad60b7f737b517aa70d809d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0b9e7b22b55bb1af92c39aa02edd573354f140399713a1258048bb3b026aaf230d039e5605c6939aaae38290ea4677c29a0e3f6d54a0d484d39c323fbb7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4157358a2ca6e01a0946875f104f4bdda516073d4790fabeba92d285738f66c04834cd168e1a12ab9c4ca60338c4c35ef78e255fbfbdbfaef8e42db3f15f952"} build_url:https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/ei9eQzvbRtyfEgRlgiWs9A/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/a08bd159aa0bebe27c385b094d85f8d015042e6ea034ebeb49378c7f6c56e05813c1b14d9c9582afe1bdb908eed044cb2bf6754ad60b7f737b517aa70d809d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0b9e7b22b55bb1af92c39aa02edd573354f140399713a1258048bb3b026aaf230d039e5605c6939aaae38290ea4677c29a0e3f6d54a0d484d39c323fbb7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4157358a2ca6e01a0946875f104f4bdda516073d4790fabeba92d285738f66c04834cd168e1a12ab9c4ca60338c4c35ef78e255fbfbdbfaef8e42db3f15f952"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 03:54:51.996435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:54:51.996754) ========= 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=fa44defc139c4ba8574fe040000001db-1475836229.423111-1775097782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 03:54:52.182337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 03:54:52.182710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 03:54:52.183037) ========= ========= Total master_lag: 0.29 =========