builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1475603806.84 results: success (0) buildid: 20161004081900 builduid: 9d41020051be4d7a8286fed0ea884e78 revision: 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:46.837846) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:46.838267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:46.838541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:46.925340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:46.925593) ========= 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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 10:56:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-10-04 10:56:47 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.112217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.112544) ========= 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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013971 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.165475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.165841) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 --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 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 --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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 10:56:48,078 truncating revision to first 12 chars 2016-10-04 10:56:48,078 Setting DEBUG logging. 2016-10-04 10:56:48,078 attempt 1/10 2016-10-04 10:56:48,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7782771c5a24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 10:56:48,369 unpacking tar archive at: mozilla-aurora-7782771c5a24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.899934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.900270) ========= script_repo_revision: 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.900686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.900954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 10:56:47.915927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-04 10:56:47.916195) ========= /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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:48 INFO - MultiFileLogger online at 20161004 10:56:48 in /builds/slave/test 10:56:48 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 10:56:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:48 INFO - {'append_to_log': False, 10:56:48 INFO - 'base_work_dir': '/builds/slave/test', 10:56:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:56:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:48 INFO - 'branch': 'Mozilla-Aurora', 10:56:48 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:48 INFO - 'config_files': ('talos/linux_config.py',), 10:56:48 INFO - 'default_actions': ('clobber', 10:56:48 INFO - 'read-buildbot-config', 10:56:48 INFO - 'download-and-extract', 10:56:48 INFO - 'populate-webroot', 10:56:48 INFO - 'create-virtualenv', 10:56:48 INFO - 'install', 10:56:48 INFO - 'run-tests'), 10:56:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:48 INFO - 'download_minidump_stackwalk': True, 10:56:48 INFO - 'download_symbols': 'ondemand', 10:56:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:48 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:48 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:48 INFO - 'installer_path': 'installer.exe', 10:56:48 INFO - 'log_level': 'info', 10:56:48 INFO - 'log_name': 'talos', 10:56:48 INFO - 'log_to_console': True, 10:56:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:48 INFO - 'opt_config_files': (), 10:56:48 INFO - 'pip_index': False, 10:56:48 INFO - 'sps_profile': False, 10:56:48 INFO - 'sps_profile_interval': 0, 10:56:48 INFO - 'suite': 'dromaeojs', 10:56:48 INFO - 'system_bits': '32', 10:56:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:48 INFO - 'title': 'talos-linux64-ix-050', 10:56:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:48 INFO - 'use_talos_json': True, 10:56:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:48 INFO - 'work_dir': 'build'} 10:56:48 INFO - [mozharness: 2016-10-04 17:56:48.921322Z] Running clobber step. 10:56:48 INFO - Running pre-action listener: _resource_record_pre_action 10:56:48 INFO - Running main action method: clobber 10:56:48 INFO - rmtree: /builds/slave/test/build 10:56:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:49 INFO - Running post-action listener: _resource_record_post_action 10:56:49 INFO - [mozharness: 2016-10-04 17:56:49.378665Z] Finished clobber step (success) 10:56:49 INFO - [mozharness: 2016-10-04 17:56:49.378766Z] Running read-buildbot-config step. 10:56:49 INFO - Running pre-action listener: _resource_record_pre_action 10:56:49 INFO - Running main action method: read_buildbot_config 10:56:49 INFO - Using buildbot properties: 10:56:49 INFO - { 10:56:49 INFO - "project": "", 10:56:49 INFO - "product": "firefox", 10:56:49 INFO - "script_repo_revision": "production", 10:56:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:56:49 INFO - "repository": "", 10:56:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:56:49 INFO - "buildid": "20161004081900", 10:56:49 INFO - "pgo_build": "True", 10:56:49 INFO - "basedir": "/builds/slave/test", 10:56:49 INFO - "buildnumber": 804, 10:56:49 INFO - "slavename": "talos-linux64-ix-050", 10:56:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:56:49 INFO - "platform": "ubuntu64_hw", 10:56:49 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:56:49 INFO - "branch": "mozilla-aurora", 10:56:49 INFO - "repo_path": "releases/mozilla-aurora", 10:56:49 INFO - "revision": "7782771c5a24c5fe2fdcba8068596ec6a850f1c8", 10:56:49 INFO - "stage_platform": "linux64-pgo", 10:56:49 INFO - "builduid": "9d41020051be4d7a8286fed0ea884e78", 10:56:49 INFO - "slavebuilddir": "test" 10:56:49 INFO - } 10:56:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 10:56:49 INFO - Running post-action listener: _resource_record_post_action 10:56:49 INFO - [mozharness: 2016-10-04 17:56:49.381213Z] Finished read-buildbot-config step (success) 10:56:49 INFO - [mozharness: 2016-10-04 17:56:49.381304Z] Running download-and-extract step. 10:56:49 INFO - Running pre-action listener: _resource_record_pre_action 10:56:49 INFO - Running main action method: download_and_extract 10:56:49 INFO - mkdir: /builds/slave/test/build/tests 10:56:49 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')]} 10:56:49 INFO - trying https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 10:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/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 10:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/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 10:56:49 INFO - Downloaded 1361 bytes. 10:56:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 10:56:49 INFO - Using the following test package requirements: 10:56:49 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 10:56:49 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:49 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:56:49 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'jsshell-linux-x86_64.zip'], 10:56:49 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:49 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 10:56:49 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:56:49 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:56:49 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:49 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:49 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 10:56:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:56:50 INFO - Expected file size: 21905888 10:56:55 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 10:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 10:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:56:55 INFO - Expected file size: 21905888 10:57:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 10:57:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:57:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:57:01 INFO - Expected file size: 14414059 10:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:02 INFO - trying https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:57:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/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 10:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/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 10:57:04 INFO - Downloaded 63934500 bytes. 10:57:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:57:04 INFO - mkdir: /builds/slave/test/properties 10:57:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:04 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:04 INFO - Contents: 10:57:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:57:06 INFO - Running post-action listener: _resource_record_post_action 10:57:06 INFO - Running post-action listener: set_extra_try_arguments 10:57:06 INFO - [mozharness: 2016-10-04 17:57:06.338959Z] Finished download-and-extract step (success) 10:57:06 INFO - [mozharness: 2016-10-04 17:57:06.339188Z] Running populate-webroot step. 10:57:06 INFO - Running pre-action listener: _resource_record_pre_action 10:57:06 INFO - Running main action method: populate_webroot 10:57:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:06 INFO - '--tppagecycles', 10:57:06 INFO - '7'], 10:57:06 INFO - 'tests': ['tsvgm']}}, 10:57:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:57:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:57:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:57:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['damp', 'tps']}, 10:57:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'tests': ['damp', 'tps']}, 10:57:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['dromaeo_dom']}, 10:57:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['basic_compositor_video']}, 10:57:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:57:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'other-e10s': {'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['a11yr', 10:57:06 INFO - 'ts_paint', 10:57:06 INFO - 'tpaint', 10:57:06 INFO - 'sessionrestore', 10:57:06 INFO - 'sessionrestore_no_auto_restore', 10:57:06 INFO - 'tabpaint']}, 10:57:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['tsvgx', 10:57:06 INFO - 'tsvgr_opacity', 10:57:06 INFO - 'tart', 10:57:06 INFO - 'tscrollx', 10:57:06 INFO - 'cart']}, 10:57:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:57:06 INFO - 'tsvgr_opacity', 10:57:06 INFO - 'tart', 10:57:06 INFO - 'tscrollx', 10:57:06 INFO - 'cart']}, 10:57:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'talos_options': ['--disable-e10s'], 10:57:06 INFO - 'tests': ['tp5o']}, 10:57:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'tests': ['tp5o']}, 10:57:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'talos_options': ['--disable-e10s', 10:57:06 INFO - '--xperf_path', 10:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:06 INFO - 'tests': ['tp5n']}, 10:57:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:06 INFO - 'talos_options': ['--xperf_path', 10:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:06 INFO - 'tests': ['tp5n']}}, 10:57:06 INFO - 'talos.zip': {'path': '', 10:57:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:06 INFO - Running post-action listener: _resource_record_post_action 10:57:06 INFO - [mozharness: 2016-10-04 17:57:06.354724Z] Finished populate-webroot step (success) 10:57:06 INFO - [mozharness: 2016-10-04 17:57:06.354812Z] Running create-virtualenv step. 10:57:06 INFO - Running pre-action listener: _resource_record_pre_action 10:57:06 INFO - Running main action method: create_virtualenv 10:57:06 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:06 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 10:57:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:06 INFO - Using real prefix '/usr' 10:57:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:06 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:08 INFO - Installing pip.................done. 10:57:08 INFO - Return code: 0 10:57:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:08 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 10:57:08 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 10:57:08 INFO - Using env: {'DISPLAY': ':0', 10:57:08 INFO - 'HOME': '/home/cltbld', 10:57:08 INFO - 'LANG': 'en_US.UTF-8', 10:57:08 INFO - 'LANGUAGE': 'en_US:en', 10:57:08 INFO - 'LOGNAME': 'cltbld', 10:57:08 INFO - 'MAIL': '/var/mail/cltbld', 10:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:08 INFO - 'MOZ_NO_REMOTE': '1', 10:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:08 INFO - 'NO_EM_RESTART': '1', 10:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:08 INFO - 'PWD': '/builds/slave/test', 10:57:08 INFO - 'SHELL': '/bin/bash', 10:57:08 INFO - 'SHLVL': '1', 10:57:08 INFO - 'TERM': 'linux', 10:57:08 INFO - 'TMOUT': '86400', 10:57:08 INFO - 'USER': 'cltbld', 10:57:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:08 INFO - '_': '/tools/buildbot/bin/python'} 10:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:09 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 10:57:09 INFO - Cleaning up... 10:57:09 INFO - Return code: 0 10:57:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:57:09 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')]} 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 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')]} 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:09 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 10:57:09 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 10:57:09 INFO - Using env: {'DISPLAY': ':0', 10:57:09 INFO - 'HOME': '/home/cltbld', 10:57:09 INFO - 'LANG': 'en_US.UTF-8', 10:57:09 INFO - 'LANGUAGE': 'en_US:en', 10:57:09 INFO - 'LOGNAME': 'cltbld', 10:57:09 INFO - 'MAIL': '/var/mail/cltbld', 10:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:09 INFO - 'MOZ_NO_REMOTE': '1', 10:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:09 INFO - 'NO_EM_RESTART': '1', 10:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:09 INFO - 'PWD': '/builds/slave/test', 10:57:09 INFO - 'SHELL': '/bin/bash', 10:57:09 INFO - 'SHLVL': '1', 10:57:09 INFO - 'TERM': 'linux', 10:57:09 INFO - 'TMOUT': '86400', 10:57:09 INFO - 'USER': 'cltbld', 10:57:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:09 INFO - '_': '/tools/buildbot/bin/python'} 10:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:09 INFO - Downloading/unpacking psutil>=3.1.1 10:57:09 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 10:57:09 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 10:57:09 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 10:57:09 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 10:57:09 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 10:57:09 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 10:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:13 INFO - Installing collected packages: psutil 10:57:13 INFO - Running setup.py install for psutil 10:57:13 INFO - building 'psutil._psutil_linux' extension 10:57:13 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 10:57:13 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 10:57:13 INFO - building 'psutil._psutil_posix' extension 10:57:13 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 10:57:13 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 10:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:13 INFO - Successfully installed psutil 10:57:13 INFO - Cleaning up... 10:57:13 INFO - Return code: 0 10:57:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:57:13 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')]} 10:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:13 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')]} 10:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:13 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:13 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 10:57:13 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 10:57:13 INFO - Using env: {'DISPLAY': ':0', 10:57:13 INFO - 'HOME': '/home/cltbld', 10:57:13 INFO - 'LANG': 'en_US.UTF-8', 10:57:13 INFO - 'LANGUAGE': 'en_US:en', 10:57:13 INFO - 'LOGNAME': 'cltbld', 10:57:13 INFO - 'MAIL': '/var/mail/cltbld', 10:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:13 INFO - 'MOZ_NO_REMOTE': '1', 10:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:13 INFO - 'NO_EM_RESTART': '1', 10:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:13 INFO - 'PWD': '/builds/slave/test', 10:57:13 INFO - 'SHELL': '/bin/bash', 10:57:13 INFO - 'SHLVL': '1', 10:57:13 INFO - 'TERM': 'linux', 10:57:13 INFO - 'TMOUT': '86400', 10:57:13 INFO - 'USER': 'cltbld', 10:57:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:13 INFO - '_': '/tools/buildbot/bin/python'} 10:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:57:16 INFO - Installing collected packages: mozsystemmonitor 10:57:16 INFO - Running setup.py install for mozsystemmonitor 10:57:16 INFO - Successfully installed mozsystemmonitor 10:57:16 INFO - Cleaning up... 10:57:16 INFO - Return code: 0 10:57:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:57:16 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')]} 10:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:16 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')]} 10:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:16 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:16 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 10:57:16 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 10:57:16 INFO - Using env: {'DISPLAY': ':0', 10:57:16 INFO - 'HOME': '/home/cltbld', 10:57:16 INFO - 'LANG': 'en_US.UTF-8', 10:57:16 INFO - 'LANGUAGE': 'en_US:en', 10:57:16 INFO - 'LOGNAME': 'cltbld', 10:57:16 INFO - 'MAIL': '/var/mail/cltbld', 10:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:16 INFO - 'MOZ_NO_REMOTE': '1', 10:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:16 INFO - 'NO_EM_RESTART': '1', 10:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:16 INFO - 'PWD': '/builds/slave/test', 10:57:16 INFO - 'SHELL': '/bin/bash', 10:57:16 INFO - 'SHLVL': '1', 10:57:16 INFO - 'TERM': 'linux', 10:57:16 INFO - 'TMOUT': '86400', 10:57:16 INFO - 'USER': 'cltbld', 10:57:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:16 INFO - '_': '/tools/buildbot/bin/python'} 10:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:16 INFO - Downloading/unpacking jsonschema==2.5.1 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:19 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:19 INFO - warning: no files found matching '*.txt' 10:57:19 INFO - no previously-included directories found matching 'build' 10:57:19 INFO - no previously-included directories found matching 'dist' 10:57:19 INFO - no previously-included directories found matching '.git*' 10:57:19 INFO - Installing collected packages: jsonschema, functools32 10:57:19 INFO - Running setup.py install for functools32 10:57:19 INFO - warning: no files found matching '*.txt' 10:57:19 INFO - no previously-included directories found matching 'build' 10:57:19 INFO - no previously-included directories found matching 'dist' 10:57:19 INFO - no previously-included directories found matching '.git*' 10:57:19 INFO - Successfully installed jsonschema functools32 10:57:19 INFO - Cleaning up... 10:57:19 INFO - Return code: 0 10:57:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:19 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 10:57:19 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 10:57:19 INFO - Using env: {'DISPLAY': ':0', 10:57:19 INFO - 'HOME': '/home/cltbld', 10:57:19 INFO - 'LANG': 'en_US.UTF-8', 10:57:19 INFO - 'LANGUAGE': 'en_US:en', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MAIL': '/var/mail/cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SHLVL': '1', 10:57:19 INFO - 'TERM': 'linux', 10:57:19 INFO - 'TMOUT': '86400', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - '_': '/tools/buildbot/bin/python'} 10:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:57:19 INFO - Cleaning up... 10:57:19 INFO - Return code: 0 10:57:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:19 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 10:57:19 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 10:57:19 INFO - Using env: {'DISPLAY': ':0', 10:57:19 INFO - 'HOME': '/home/cltbld', 10:57:19 INFO - 'LANG': 'en_US.UTF-8', 10:57:19 INFO - 'LANGUAGE': 'en_US:en', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MAIL': '/var/mail/cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SHLVL': '1', 10:57:19 INFO - 'TERM': 'linux', 10:57:19 INFO - 'TMOUT': '86400', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - '_': '/tools/buildbot/bin/python'} 10:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:19 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 10:57:19 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 10:57:19 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 10:57:19 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 10:57:19 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 10:57:19 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 10:57:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:21 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 10:57:21 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 10:57:21 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 10:57:21 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 10:57:21 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 10:57:21 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 10:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 INFO - Downloading docopt-0.6.1.tar.gz 10:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:22 INFO - Running setup.py install for blobuploader 10:57:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:22 INFO - Running setup.py install for requests 10:57:22 INFO - Running setup.py install for docopt 10:57:22 INFO - Successfully installed blobuploader requests docopt 10:57:22 INFO - Cleaning up... 10:57:22 INFO - Return code: 0 10:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:22 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 10:57:22 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 10:57:22 INFO - Using env: {'DISPLAY': ':0', 10:57:22 INFO - 'HOME': '/home/cltbld', 10:57:22 INFO - 'LANG': 'en_US.UTF-8', 10:57:22 INFO - 'LANGUAGE': 'en_US:en', 10:57:22 INFO - 'LOGNAME': 'cltbld', 10:57:22 INFO - 'MAIL': '/var/mail/cltbld', 10:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:22 INFO - 'MOZ_NO_REMOTE': '1', 10:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:22 INFO - 'NO_EM_RESTART': '1', 10:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:22 INFO - 'PWD': '/builds/slave/test', 10:57:22 INFO - 'SHELL': '/bin/bash', 10:57:22 INFO - 'SHLVL': '1', 10:57:22 INFO - 'TERM': 'linux', 10:57:22 INFO - 'TMOUT': '86400', 10:57:22 INFO - 'USER': 'cltbld', 10:57:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:22 INFO - '_': '/tools/buildbot/bin/python'} 10:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:23 INFO - Running setup.py (path:/tmp/pip-LjZhc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:23 INFO - Running setup.py (path:/tmp/pip-mlIjX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:23 INFO - Running setup.py (path:/tmp/pip-6UHrwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:23 INFO - Running setup.py (path:/tmp/pip-rH65zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:23 INFO - Running setup.py (path:/tmp/pip-IKvzwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:23 INFO - Running setup.py (path:/tmp/pip-s1Y0WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:23 INFO - Running setup.py (path:/tmp/pip-hljRZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:23 INFO - Running setup.py (path:/tmp/pip-jNJrlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:23 INFO - Running setup.py (path:/tmp/pip-ILmhHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:23 INFO - Running setup.py (path:/tmp/pip-yVUajg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:23 INFO - Running setup.py (path:/tmp/pip-zWB__2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:23 INFO - Running setup.py (path:/tmp/pip-ubfkLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:24 INFO - Running setup.py (path:/tmp/pip-MdMXpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:24 INFO - Running setup.py (path:/tmp/pip-9wUvWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:24 INFO - Running setup.py (path:/tmp/pip-XzMHLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:24 INFO - Running setup.py (path:/tmp/pip-e8siwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:24 INFO - Running setup.py (path:/tmp/pip-B03y4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:24 INFO - Running setup.py install for manifestparser 10:57:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:24 INFO - Running setup.py install for mozcrash 10:57:24 INFO - Running setup.py install for mozdebug 10:57:24 INFO - Running setup.py install for mozdevice 10:57:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:24 INFO - Running setup.py install for mozfile 10:57:24 INFO - Running setup.py install for mozhttpd 10:57:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozinfo 10:57:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozInstall 10:57:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozleak 10:57:25 INFO - Running setup.py install for mozlog 10:57:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for moznetwork 10:57:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozprocess 10:57:25 INFO - Running setup.py install for mozprofile 10:57:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozrunner 10:57:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Running setup.py install for mozscreenshot 10:57:25 INFO - Running setup.py install for moztest 10:57:26 INFO - Running setup.py install for mozversion 10:57:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:26 INFO - Cleaning up... 10:57:26 INFO - Return code: 0 10:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:26 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')]} 10:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 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')]} 10:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:26 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 10:57:26 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 10:57:26 INFO - Using env: {'DISPLAY': ':0', 10:57:26 INFO - 'HOME': '/home/cltbld', 10:57:26 INFO - 'LANG': 'en_US.UTF-8', 10:57:26 INFO - 'LANGUAGE': 'en_US:en', 10:57:26 INFO - 'LOGNAME': 'cltbld', 10:57:26 INFO - 'MAIL': '/var/mail/cltbld', 10:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:26 INFO - 'MOZ_NO_REMOTE': '1', 10:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:26 INFO - 'NO_EM_RESTART': '1', 10:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:26 INFO - 'PWD': '/builds/slave/test', 10:57:26 INFO - 'SHELL': '/bin/bash', 10:57:26 INFO - 'SHLVL': '1', 10:57:26 INFO - 'TERM': 'linux', 10:57:26 INFO - 'TMOUT': '86400', 10:57:26 INFO - 'USER': 'cltbld', 10:57:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:26 INFO - '_': '/tools/buildbot/bin/python'} 10:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:26 INFO - Running setup.py (path:/tmp/pip-S9iN_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:26 INFO - Running setup.py (path:/tmp/pip-_JHvWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:26 INFO - Running setup.py (path:/tmp/pip-2vkCec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:26 INFO - Running setup.py (path:/tmp/pip-nOResY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:26 INFO - Running setup.py (path:/tmp/pip-lNXBYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:26 INFO - Running setup.py (path:/tmp/pip-bDSFxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:26 INFO - Running setup.py (path:/tmp/pip-xLD7gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:26 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)) 10:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:26 INFO - Running setup.py (path:/tmp/pip-E2xZzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:27 INFO - Running setup.py (path:/tmp/pip-2Rg3gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:27 INFO - Running setup.py (path:/tmp/pip-QvJ97F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:27 INFO - Running setup.py (path:/tmp/pip-y4t4jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:27 INFO - Running setup.py (path:/tmp/pip-qqy6_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:27 INFO - Running setup.py (path:/tmp/pip-FHMFcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:27 INFO - Running setup.py (path:/tmp/pip-E9HKrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:27 INFO - Running setup.py (path:/tmp/pip-OOua3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:27 INFO - Running setup.py (path:/tmp/pip-3k1Pw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:27 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)) 10:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:27 INFO - Running setup.py (path:/tmp/pip-_p6BLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:27 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)) 10:57:27 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)) 10:57:27 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)) 10:57:27 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)) 10:57:27 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)) 10:57:27 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)) 10:57:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:29 INFO - Downloading blessings-1.6.tar.gz 10:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:29 INFO - Installing collected packages: blessings 10:57:29 INFO - Running setup.py install for blessings 10:57:29 INFO - Successfully installed blessings 10:57:29 INFO - Cleaning up... 10:57:29 INFO - Return code: 0 10:57:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:30 INFO - Reading from file tmpfile_stdout 10:57:30 INFO - Current package versions: 10:57:30 INFO - argparse == 1.2.1 10:57:30 INFO - blessings == 1.6 10:57:30 INFO - blobuploader == 1.2.4 10:57:30 INFO - docopt == 0.6.1 10:57:30 INFO - functools32 == 3.2.3-2 10:57:30 INFO - jsonschema == 2.5.1 10:57:30 INFO - manifestparser == 1.1 10:57:30 INFO - mozInstall == 1.12 10:57:30 INFO - mozcrash == 0.17 10:57:30 INFO - mozdebug == 0.1 10:57:30 INFO - mozdevice == 0.48 10:57:30 INFO - mozfile == 1.2 10:57:30 INFO - mozhttpd == 0.7 10:57:30 INFO - mozinfo == 0.9 10:57:30 INFO - mozleak == 0.1 10:57:30 INFO - mozlog == 3.4 10:57:30 INFO - moznetwork == 0.27 10:57:30 INFO - mozprocess == 0.23 10:57:30 INFO - mozprofile == 0.28 10:57:30 INFO - mozrunner == 6.12 10:57:30 INFO - mozscreenshot == 0.1 10:57:30 INFO - mozsystemmonitor == 0.3 10:57:30 INFO - moztest == 0.7 10:57:30 INFO - mozversion == 1.4 10:57:30 INFO - psutil == 3.1.1 10:57:30 INFO - requests == 1.2.3 10:57:30 INFO - wsgiref == 0.1.2 10:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 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 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:30 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 10:57:30 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 10:57:30 INFO - Using env: {'DISPLAY': ':0', 10:57:30 INFO - 'HOME': '/home/cltbld', 10:57:30 INFO - 'LANG': 'en_US.UTF-8', 10:57:30 INFO - 'LANGUAGE': 'en_US:en', 10:57:30 INFO - 'LOGNAME': 'cltbld', 10:57:30 INFO - 'MAIL': '/var/mail/cltbld', 10:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:30 INFO - 'MOZ_NO_REMOTE': '1', 10:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:30 INFO - 'NO_EM_RESTART': '1', 10:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:30 INFO - 'PWD': '/builds/slave/test', 10:57:30 INFO - 'SHELL': '/bin/bash', 10:57:30 INFO - 'SHLVL': '1', 10:57:30 INFO - 'TERM': 'linux', 10:57:30 INFO - 'TMOUT': '86400', 10:57:30 INFO - 'USER': 'cltbld', 10:57:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:30 INFO - '_': '/tools/buildbot/bin/python'} 10:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 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)) 10:57:30 INFO - Cleaning up... 10:57:30 INFO - Return code: 0 10:57:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f883f9aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', '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 10:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:57:30 INFO - Using env: {'DISPLAY': ':0', 10:57:30 INFO - 'HOME': '/home/cltbld', 10:57:30 INFO - 'LANG': 'en_US.UTF-8', 10:57:30 INFO - 'LANGUAGE': 'en_US:en', 10:57:30 INFO - 'LOGNAME': 'cltbld', 10:57:30 INFO - 'MAIL': '/var/mail/cltbld', 10:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:30 INFO - 'MOZ_NO_REMOTE': '1', 10:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:30 INFO - 'NO_EM_RESTART': '1', 10:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:30 INFO - 'PWD': '/builds/slave/test', 10:57:30 INFO - 'SHELL': '/bin/bash', 10:57:30 INFO - 'SHLVL': '1', 10:57:30 INFO - 'TERM': 'linux', 10:57:30 INFO - 'TMOUT': '86400', 10:57:30 INFO - 'USER': 'cltbld', 10:57:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:30 INFO - '_': '/tools/buildbot/bin/python'} 10:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:57:30 INFO - Cleaning up... 10:57:30 INFO - Return code: 0 10:57:30 INFO - Running post-action listener: _resource_record_post_action 10:57:30 INFO - Running post-action listener: _start_resource_monitoring 10:57:30 INFO - Starting resource monitoring. 10:57:30 INFO - [mozharness: 2016-10-04 17:57:30.515086Z] Finished create-virtualenv step (success) 10:57:30 INFO - [mozharness: 2016-10-04 17:57:30.515548Z] Running install step. 10:57:30 INFO - Running pre-action listener: _resource_record_pre_action 10:57:30 INFO - Running main action method: install 10:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:30 INFO - Reading from file tmpfile_stdout 10:57:30 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:30 INFO - Reading from file tmpfile_stdout 10:57:30 INFO - Output received: 10:57:30 INFO - Usage: mozinstall [options] installer 10:57:30 INFO - Options: 10:57:30 INFO - -h, --help show this help message and exit 10:57:30 INFO - -d DEST, --destination=DEST 10:57:30 INFO - Directory to install application into. [default: 10:57:30 INFO - "/builds/slave/test"] 10:57:30 INFO - --app=APP Application being installed. [default: firefox] 10:57:30 INFO - mkdir: /builds/slave/test/build/application 10:57:30 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'] 10:57:30 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 10:57:46 INFO - Reading from file tmpfile_stdout 10:57:46 INFO - Output received: 10:57:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:57:46 INFO - Running post-action listener: _resource_record_post_action 10:57:46 INFO - [mozharness: 2016-10-04 17:57:46.755351Z] Finished install step (success) 10:57:46 INFO - [mozharness: 2016-10-04 17:57:46.755595Z] Running run-tests step. 10:57:46 INFO - Running pre-action listener: _resource_record_pre_action 10:57:46 INFO - Running main action method: run_tests 10:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:46 INFO - Python 2.7.3 10:57:46 INFO - Return code: 0 10:57:46 INFO - grabbing minidump binary from tooltool 10:57:46 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')]} 10:57:46 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 0x1b02f60>, '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 0x1b03d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b041d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:46 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 10:57:46 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 10:57:46 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 10:57:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:46 INFO - Return code: 0 10:57:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:57:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:57:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:46 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/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:57:46 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/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:57:46 INFO - Using env: {'DISPLAY': ':0', 10:57:46 INFO - 'HOME': '/home/cltbld', 10:57:46 INFO - 'LANG': 'en_US.UTF-8', 10:57:46 INFO - 'LANGUAGE': 'en_US:en', 10:57:46 INFO - 'LOGNAME': 'cltbld', 10:57:46 INFO - 'MAIL': '/var/mail/cltbld', 10:57:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:46 INFO - 'MOZ_NO_REMOTE': '1', 10:57:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:46 INFO - 'NO_EM_RESTART': '1', 10:57:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:46 INFO - 'PWD': '/builds/slave/test', 10:57:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:46 INFO - 'SHELL': '/bin/bash', 10:57:46 INFO - 'SHLVL': '1', 10:57:46 INFO - 'TERM': 'linux', 10:57:46 INFO - 'TMOUT': '86400', 10:57:46 INFO - 'USER': 'cltbld', 10:57:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618', 10:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:46 INFO - '_': '/tools/buildbot/bin/python'} 10:57:46 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/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:57:47 INFO - mozversion application_buildid: 20161004081900 10:57:47 INFO - mozversion application_changeset: 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 10:57:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:57:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:47 INFO - mozversion application_name: Firefox 10:57:47 INFO - mozversion application_remotingname: firefox-dev 10:57:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:57:47 INFO - mozversion application_vendor: Mozilla 10:57:47 INFO - mozversion application_version: 51.0a2 10:57:47 INFO - mozversion platform_buildid: 20161004081900 10:57:47 INFO - mozversion platform_changeset: 7782771c5a24c5fe2fdcba8068596ec6a850f1c8 10:57:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:57:47 INFO - mozversion platform_version: 51.0a2 10:57:47 INFO - using testdate: 1475603867 10:57:47 INFO - actual date: 1475603867 10:57:47 INFO - starting webserver on 'localhost:45796' 10:57:47 INFO - SUITE-START | Running 2 tests 10:57:47 INFO - TEST-START | dromaeo_css 10:57:47 INFO - operating with platform_type : linux_ 10:57:47 INFO - Initialising browser for dromaeo_css test... 10:57:47 INFO - TEST-INFO | started process 23292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnHKKg/profile http://localhost:45796/getInfo.html) 10:57:50 INFO - PROCESS | 23292 | __metrics Screen width/height:1600/1200 10:57:50 INFO - PROCESS | 23292 | colorDepth:24 10:57:50 INFO - PROCESS | 23292 | Browser inner width/height: 1024/697 10:57:50 INFO - PROCESS | 23292 | __metrics 10:57:51 INFO - PROCESS | 23292 | 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" 10:57:51 INFO - PROCESS | 23292 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:51 INFO - PROCESS | 23292 | console.error: PushService: 10:57:51 INFO - PROCESS | 23292 | stateChangeProcessEnqueue: Error transitioning state 10:57:51 INFO - PROCESS | 23292 | UnknownError 10:57:52 INFO - TEST-INFO | 23292: exit 0 10:57:52 INFO - Browser initialized. 10:57:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:52 INFO - TEST-INFO | started process 23381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnHKKg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:04 INFO - PROCESS | 23381 | RSS: Main: 144527360 10:58:04 INFO - PROCESS | 23381 | 10:58:55 INFO - PROCESS | 23381 | 1475603935334 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] 11:01:04 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45796/tests/dromaeo/cssquery-ext.html) 11:01:05 INFO - PROCESS | 23381 | RSS: Main: 233418752 11:01:05 INFO - PROCESS | 23381 | 11:04:07 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-ext.html (next: http://localhost:45796/tests/dromaeo/cssquery-jquery.html) 11:04:08 INFO - PROCESS | 23381 | RSS: Main: 229359616 11:04:08 INFO - PROCESS | 23381 | 11:07:10 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45796/tests/dromaeo/cssquery-mootools.html) 11:07:11 INFO - PROCESS | 23381 | RSS: Main: 175132672 11:07:11 INFO - PROCESS | 23381 | 11:10:13 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45796/tests/dromaeo/cssquery-prototype.html) 11:10:13 INFO - PROCESS | 23381 | RSS: Main: 173580288 11:10:13 INFO - PROCESS | 23381 | 11:13:16 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45796/tests/dromaeo/cssquery-yui.html) 11:13:16 INFO - PROCESS | 23381 | RSS: Main: 173010944 11:13:16 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | Cycle 1(1): loaded http://localhost:45796/tests/dromaeo/cssquery-yui.html (next: http://localhost:45796/tests/dromaeo/cssquery-dojo.html) 11:16:19 INFO - PROCESS | 23381 | RSS: Main: 265080832 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | __start_tp_report 11:16:19 INFO - PROCESS | 23381 | _x_x_mozilla_page_load 11:16:19 INFO - PROCESS | 23381 | _x_x_mozilla_page_load_details 11:16:19 INFO - PROCESS | 23381 | |i|pagename|runs| 11:16:19 INFO - PROCESS | 23381 | |0;dojo.html;3117.5011998080304;3136.5452009458627;3151.1176870476274;3172.8413579321027;3190.505471651895;5554.722263886804;5644.943550564493;5663.745131469083;5678.176664383656;5686.857828554278;5754.16564598134;5822.126680997852;5827.329857066438;5832.708364581765;5871.266091738533;5201.791928322863;5229.267902493654;5246.947530524703;5267.973660131694;5308.840734777963;5101.923471147936;5108.948910510884;5325.653832500875;5333.466653334654;5368.70472124033;5086.745662716868;5166.612504062192;5233.293505376782;5236.738163091849;5238.52853243208;5129.512696293846;5147.202183661539;5200.6879587224885;5221.06020916235;5221.738913054332;5147.073526765181;5245.659032162897;5252.65857719247;5255.737213139328;5284.048871203182;5550.056490396642;5602.327720673505;5606.55147588192;5708.914366284509;5728.484436400744;6056.697165141725;6065.302490213594;6069.6054756441135;6079.939200607982;6086.543509236825;6168.684282482795;6189.81430557084;6219.09823075656;6224.408681175281;6225;5548.0845660466375;5600.047991841397;5600.691961942132;5807.30312362515;5823.592348535604;6113.541484388688;6117.855613428804;6141.1791743482045;6259.0924315973925;6260.561760676709;5993.790217342372;6012.218411606551;6013.218281623448;6022.281844386149;6049.153118563405;5960.612560183574;6017.428344307284;6097.298810636745;6102.8169154924535;6104.847378815565;5931.9406805931385;5977.252843394575;5989.311229208697;6023.518118550505;6071.210742603434;5994.490468310242;6047.244094488189;6061.3029501607;6064.9090263646085;6097.695115244309;4536.047430039728;4617.1227466781875;4643.976780116078;4656.3946686930485;4676.625869930397;4046.2109888572036;4071.91856162881;4110.013596736761;4112.691548133902;4173.686973477002;5813.476787089182;5818.94181058184;5820.505257053198;5820.738066787005;5823.82528524145;6100.603460775035;6112.51099912006;6115.113308570232;6116.327204007555;6125.479334256638;5727.198192253088;5784.363719990798;5795.1017592273265;5852.356240813507;5856.765729370777;5357.19642053695;5373.650712703662;5374.381946076173;5379.623426360117;5396.163594642758;6339.112524246517;6363.140975968277;6422.4862011039;6423.197100362455;6426.8714625707225;5931.9110213345975;5982;6096.055111457731;6158.630482171084;6226.470749986302;6299.716512757029;6404.551681382259;6407.903881441689;6419.165508483868;6419.839504012437;6043.848903777441;6059.091136329585;6078.3617720138745;6083.482903953213;6085.665288409003;5860.2967643883;5947.6431414115295;6038.75844966214;6187.84530386744;6203.689815509116;5858.355580886185;5931.703414829328;5985.610935289193;6002.219711437485;6024.819255422344;5962.493188079062;5979.372165922689;5982.0727787193055;5992.101184822312;5999.1601175836295;5641.464060914206;5759.078547432391;5918.556108291809;5920.555958303231;5922.289325280994;5905.822825315247;5951.404859514188;5962.284525856925;5991.221141251609;6021.819345419644;5824.767009319579;5860.355360910382;5867.970660146672;5877.823665290048;5879.382664820303 11:16:19 INFO - PROCESS | 23381 | |1;ext.html;599.7151353107274;626.5582764151274;649.3668673043783;654.52546903495;657.8026592022392;34785;46048.309275360894;46278.305825412644;46348.53651463484;46377.07245855081;47288.290675639895;47751.283730744064;47772.76113619427;47792;47812.52187478124;8467.915320846774;9269.490178040205;9438.764030899214;9445.622175113022;9449.385789923668;8396.370272229577;11090.667279981613;11326.377049262288;11365.488553015135;11601.709957251052;11267.380294083821;11312.773744525104;11326.43367831605;11329;11329.320240785539;8547.95726021366;8765.693200737944;11110;11193.888061119365;11197.440127993608;10285.331453455501;10497.475126243657;10514.631987880464;10525.210609204263;10533.26267161299;44145.55854441447;44634.77682611599;44661;44669.77665111654;44699.55300446986;3878.612138786127;3950.545687245975;3989.5212574491247;4079.3473044313064;4315.331123675835;34315.828420857986;34326.31347373063;34384.484232736526;34577.65422345769;34802.47796283058;4664.416947881515;4683.95316046842;4777.307290442901;4780.163471392492;4861.829835955725;267161;267193;268473;269194;351488.2425587881;62205.68897155485;62347.376526234155;62370.376296237366;62579.6871015642;62582;40493.797531012155;41153;41407.378889316686;43340.56659433428;64986.35013649898;19437.22251109968;19608.90195549013;19633.116509757096;19638.90180549088;19648.60702785936;13767.586972390643;14008.649783755487;14209.218492982985;14975.251237438302;15101.546953591409;19659.311924082587;20374.18503259853;20401.979901004892;20450.77295362283;20458.693119603216;7209.567425954459;7375.963120184472;7410;7443.925560744432;7567.735129270559;1034.3225187502198;1057.5399701130034;1067.5462928255615;1079.7138758229075;1169.7894379011689;33720.66279337224;34131.98281458298;34243.657563424546;34339;34384.65615343865;1133.727905302738;1139.0887290167998;1168.8480497535436;1183.893449589541;1207.5532053140394;17899.37352192693;18026.90986545059;18061.819381806275;18070.3675371364;18087.909560452114;634050;642536;643536;643858;644268;61267.38732612706;61789.38210617836;61859;61878.690606546676;62046.37953620406;1294.7863602505481;1300.0574583427128;1393.2546087842954;1402.2848347342724;1450.5358285348586;32731.836340818143;34827.303453930275;35142.472862906565;35362.46956295709;35547.466787997684;52157.21764173616;52210;52782.736086319324;52886.20670690019;52945;477162;478609;478852;479160;480176;30738.692613074476;31522.369552609278;31741.682583174796;33019.66980330166;33023.00930972075;49823;50707.492925071754;50917;50981;52060.73969630279;42107.36838947357;42775.7861210692;43038.35442468303;43677.344839826794;43943.78028109839;42706.78646606747;43228;43266.4713544915;44006.11987760291;44230.77884610556;41958.58041419669;42519.14961700811;42819.78590107154;42870.78564607157;43556.12887742291;36836.631633684396;38633.80683096567;39425.80287098546;39652;39726.40410393904;29089;29155.85422072876;29193.124206273846;29218.415631687672;29595.85202073976 11:16:19 INFO - PROCESS | 23381 | |2;jquery.html;394.42807928503674;419.59928268503603;430.39744357898945;433.67474394204345;441.93370994350846;15745.291461884213;19705.5650992769;22012.559748805015;22161;22448.775512244894;19112.13995370208;19600.117994690238;19787.802121978777;20159.395218143443;20693.482662933435;5003.949960500385;5558.305211848529;5734.598578099534;5741.712914354265;5746.224259724925;5657.151427285919;6281.246250449953;6322.873542529147;6325.114483972247;6325.399087086719;5943.910841337383;6215.0366693162405;6281.183446151994;6285.497160227171;6286.528510361718;6215.471684906788;6237.875242495124;6248.7188076536895;6251.12484252205;6256.1866957295715;5858.443447872445;6090.208272924491;6141.078838174265;6158.353372895871;6164.96917515414;15431.768523472158;15676.529704108782;20536.281230157023;25309.367265818317;25490.872545637154;2463.322586288785;2533.480636469538;2559.5648739714293;2805.3126983888874;2870.942581148365;11085.390303533302;11298.830517542243;11550.075993920465;11738.06095512357;13411.932940335237;2045.263705066175;2112.3346145964124;2130.084063852543;2167.479804846841;2192.8355373347063;91586;95339;97178.51410742971;97920;98178.50910745472;10665.146788256921;11533.653990380302;11632.360220187802;11852.051835853112;12009.579664711693;15475.226238688021;15699.764503532457;16246;16280.348786048662;16283.267252973408;8413.158684131538;8591.957040214884;8998.55007249635;9010.369274150878;9074.31942604294;8702.173293537104;8733.912660873437;8814.030456649763;8911.287097032222;8961.865572016424;5152.819651312186;5198.142306519382;5219.060569097599;5232;5295.4969277918535;2065.2565076572423;2098.9085675448987;2105.747310322771;2231.6317807561895;2234.240358278193;929.869818225449;1002.4035698759227;1021.3004092196869;1021.5352014833232;1079.255313833468;20273.29043483471;20357.185712571627;20361.694574581394;20433.182672693223;20775.168993240404;1033.261218228955;1033.8604288420968;1035.29082578434;1092.4264761000538;1119.4738472917716;11084.722881927855;12152.5138994441;12205.816912746315;12238.265704057785;12473.189242699196;464708;476247;529502;546354;551517;100093.49953250187;102443.48778256061;103306;104343;110033;1072.0940805019745;1082.199172612277;1120.8206686930052;1122.820348744197;1166.1312322319925;18567.721484177477;18888.244470221038;18953.905230474313;19111.713324299868;19126.713099303244;40654.79672601618;45797.54202457933;46454.30318545292;46863.531364685914;47353;51453.22820157775;58285.708571456875;58813.41186588079;59430.40569594422;60620.696896515234;7915.248051435105;8572.35707321941;8574.056853745959;8713.825723485368;9107.635694572144;8582.09887961755;10279.640212592523;12041;13885.097468664504;14565.563033109023;11840.526378944745;11876.584319548774;12139.75720485603;12184.147109702235;12296.508139674313;12044.457999390224;12114.5834369064;12171.914042978511;12313.692157696129;12499;12264.141510094565;12424.316662583284;12505.187162834387;12573.245605263714;12765.553205637758;8448;8635.136486351315;8710.390272680852;8876.112388761072;8957.865632015655;11467.770644587228;11487.712807179887;11537.596184133516;11651.650450486499;11709.414529273672 11:16:19 INFO - PROCESS | 23381 | |3;mootools.html;1410.7883817427391;1574.9291281892317;1579.526142157353;1776.564741638298;1868.6636405447014;8525.573721313933;9490.193333566647;9755.073268039543;9774;10109.595616175362;9765.951170244156;9834.114929656329;9844.852327215098;9851.113399794018;9854.359466634663;2579.935501612456;2604.895804167831;2611.8955241790304;2613.2421597736634;2613.607958806185;2517.307740371394;2564.3204550794053;2566.114690431798;2567.6405303257557;2567.9486410271875;2507.2352932355716;2542.5677634802128;2612.804039697021;2618.541755192843;2618.646482724827;2522.1046528482398;2527.848329100251;2542.9237122886343;2551.132614910939;2558.961615575768;2441.1333976438464;2449.3019489445423;2477.9876100619563;2479.82641215115;2483.379155211197;9357.76605584859;9816.214702823829;9920.206383489376;9937.850932236022;9944.900550994542;5708.172315014342;5868.559858010623;5981.671008094553;5986.760529578812;5987.371326010793;3634.872779452733;3680.190358121236;3700.777953322809;3707.888763337104;3727.7576957497677;1278.0670110819062;1285.505080543988;1301.8372703412074;1333.4199623163954;1345.307166809094;13970.580882573538;14116.153030818185;14128.434862605483;14185.574432767033;14242.786358204636;5119.846404607868;5188.584913206934;5337.6797392156595;5341.145416733304;5422.267993820863;11953.043756499459;11955.282683039046;11964.521419143137;11982.820257696141;11992.160548761678;5855.59010869235;5916.230889984275;5919.052951527735;5921.904447677193;5944.851378715567;4439.556044395535;4623.884402889955;4824.903501929942;5359.705216213146;5391.56867450603;4457.576530229623;4496.775161241925;4556.589906908394;4584.312353146988;4616.822710208875;1422.267532220907;1436.8634979676915;1438.7050654615778;1457.227669335254;1459.5037687186407;857.2713193785357;882.761654353321;911.9603651836911;958.7363475044418;1017.308230403318;6379.681015949184;6464.127342808661;6490.318516555788;6511.088447617338;6586.907110922378;490.9705417674951;491.4323955831021;503.4512381504178;508.3239291741974;519.4545726986725;4286.957130428656;4400;4446.688731788744;4462.174497717932;4466.173757854807;11548.364839933884;11666.70833229176;11739.23694959825;11753.353565553805;11756.58851940195;11606.071514278838;11678.182527223184;11711.88288117125;11792.94103529494;12147;8664.95667521671;8868.33487488441;8877.289816814638;8906.910930890737;8933.955330223438;6644.435223006099;6803.557768745016;6914.481413893877;6959.130108736408;7025.121859767529;11125.833112503156;11422.485988130387;11484.712882178012;11485.712857178303;11672;10313.484325783531;10384.117350025332;11740.530378785095;11790.528378865092;11823.645290641294;8340.791480213044;8618.827623447622;8928.776780580538;8930.508822014592;8932.240759535252;9080.682176123804;9090.772730681521;9113.635454581743;9134.086591340812;9193.218576421079;8360.45657032291;8431.15688431152;8485.575721214038;8602.655893764178;8697.91302086971;8046.919530804851;8170.754877353451;8276.379271554779;8363.121872203574;8465.449745766506;7515.135759387522;7587.013688220496;7605.125410577854;7711.922880771345;7716.305532501877;5363.249145119765;5396.0556902542685;5437.927570922416;5440.891182176413;5502.119660854244;5526.336839579276;5559.27729395176;5617.241672374341;5626.493615574454;5721.856953576027 11:16:19 INFO - PROCESS | 23381 | |4;prototype.html;354.1217779905833;359.74817627660644;361.0486368419218;364.03167574252495;366.4082506751597;5520.392756796759;5527.917081243784;5530.64947397356;5538.4738449847255;5595.160725891118;5158.252053452247;5430.647007944491;5449.482299181582;5475.972620136894;5504.697241651707;3784;4243.32106862902;4248.150369926027;4310.956890431087;4325.940144664546;4290.97854510727;4299.849505267316;4299.892502687442;4303.24693178694;4311.426329389766;4297.183535128332;4297.978510107445;4327.446806384232;4341.978290108561;4361.498427680825;4065.8170382332864;4120.619592436522;4322.82708691652;4336.913261734748;4354.804033818486;3868.6905047596406;3872;3875.61243875613;3886.4947556817715;3912.726109172359;5314.654547454442;5333.2266821310695;5347.6256662033675;5363.517283444508;5370.812021579226;4790.42514898211;4915.3364295819965;4963.975180124113;4992.226204938204;5000.874978125539;5701.714914254312;5710.77156913723;5711.828645140652;5714.9714251428895;5721.7711291548285;4278;4280.550542193056;4291.163223171483;4295.591918767712;4338.392625032498;5607;5612.607117501777;5795.391483894173;5934.5845790794665;6031.215941927565;4139.516290225841;4246.596573325529;4259.531451540328;4264.637505812041;4289.463817022872;4301.720388174758;4334.869953901388;4338.175746608134;4342.435483387139;4347.282698354799;4669.836555720533;4872.78072486739;4878.9512104878495;4940.802367905316;4950.158473059589;5735.451428114386;5748.626339287933;5768.192453056576;5770.067027545819;5798.855028624318;1488.2261224163374;1502.4516051641071;1502.7445334293197;1521.6043828604643;1523.4820161145265;916.1800188831093;959.4866746290701;968.1673760565908;969.0938972061005;984.7587341101332;4918.163912134874;4956.3804524434445;4965.652404331662;4966.279889416014;4970.378702662168;5146.228065790161;5187.0922588546855;5205.6465319017325;5226.70717448013;5230.92153617696;4660.673752837337;4901.975490122598;4967.826126085642;4972.701637901738;5045.798168073309;2760;2762.9171124866284;2770.9747393464545;2774.9881336031217;2791.260316016257;5343;5345.518903298722;5346.278252435949;5366.202322222021;5403.2705584746345;5283.233931079972;5300.628955973122;5622.91565626516;5980.910286345708;6018.578699491081;6052.848678782978;6059.182010428536;6059.818205453844;6082.695865206811;6105.84735381619;5606.215129881738;5904.468597826216;5918.260217472816;5926.4666180044005;5949.25634295713;5778.191053252464;5847.462285317321;5862;5888.587798854039;5899.91150132757;5892.322382926019;5998.970005149947;6019.849503762441;6062.605930614496;6138.969305153446;4077.8776636700945;4172.457580514514;4235.449391579075;4277.978610106929;4289.592488713567;5745.8563535911935;5905.202797622266;5939.46544810969;5961.314448838266;5980.312264089685;5696.943030569641;5711.857203569944;5719.714014299185;5765.1928729977;5788.507976822018;5681.573881958787;5711.628744131618;5713.314402271754;5718.25662663851;5750.338711048283;5459.481349271813;5645.435456454322;5660.264165658438;5668.546516278605;5738.512226460798;5698.173764803997;5704.258446401941;5715.799682066812;5730.770769169187;5745.74144163522;5649.20911072442;5659.151127330933;5680.886382272414;5692.914606280992;5699.287589051369 11:16:19 INFO - PROCESS | 23381 | |5;yui.html;782.729958164433;808.987865182022;822.3298012120122;886.2644005475456;950.0452045694076;16476.91761541192;17005.149742512887;17291.30834766608;17378.304867805273;17417.216225269876;15323.770143447857;15544;15564.299606517705;15622.375104995815;15656.373745050185;706.8197609609542;714.9320814522612;850.7022542110243;865.2213008292556;867.5055218525443;864.9091845356241;868.6308318964446;868.8045189832301;868.8436081505326;869.6173683579204;914.7027216154743;922.2575826459697;922.9985465769648;924.2929159193222;924.6809850601531;754.6340025087856;766.264386189259;889.4352086425102;894.7807787092139;900.4642237868458;668.8829454845383;676.2459857259121;676.3980057748607;676.8510927595921;677.0318444624186;15388.076715397112;15404.46084387041;15432.92283538575;15461.458848940345;15478.767818482731;15315.540533784004;15412.450780042842;15471;15560;15914.124723140223;14163.858361416356;14305.213213273266;14362.066465679802;14707.19110448925;15051.849481505154;4561.498235194126;4577.9542204577865;4633.953660463386;4666.2067448533835;4679.461861885893;88258.5587072067;88572.11427885703;88595.55702221511;89047;89508;11537.88462115368;11811.704707382385;12016.699582510508;12032.699182520508;12101.757964840654;23491.295261142193;23552.293431197093;23577;23602.527949440915;23606.173783917482;8903.688370907117;8928.910710892807;9189.63241470347;9298.279624410394;9510.28672849539;5013.724245166551;5116.769745361467;5175.715335656575;5180.352455943007;5363.436839131835;3528.2767032758225;3665.596784353719;3665.890023299305;3688.61269566697;3689.9815500922323;680.3978479046079;709.4785332780402;710.3819676881146;711.2311948386059;722.0216606498225;793.7936136604525;827.4332082523491;840.5839109640767;842.582921453872;861.3410740783306;10386.896131038744;10802.837957430645;11065.557377704963;11363.772724545463;11734.94132529332;686.7767975408012;718.3534818663245;739.6523633892062;801.903771547418;820.9630566624517;5180.248863914787;5276.3932147802725;5353.437889021597;5378.085725426687;5394.649347792381;112866.43566782278;115131.34220942759;118919;121004.39497802455;123012.38493807474;104042;105997.47001265099;108373;108566;108924;91064;92903;95165.52417238009;96190.51904740432;97332;10154.593816247267;10288.2798204125;10417.322874013165;10425.270231083752;10532.526036328536;50855.49144508508;52256.47743522516;53393;53808.46191538034;55262.72368638131;78304.60847695953;78895.81656275275;81670;81728.18271817206;85205.57397212974;12792.104552681223;13013.21920684762;13141.671458213621;13296.667583310495;13333.66665833362;12898.613041608767;13076.411561479566;13253;13484.12353197039;13902.304884755924;13786.241756703477;13999.51001714935;14251.64370890736;14276.42894284217;14429.7835532465;13899.235542045284;14308.284585770461;14415.927920360331;14432.85567144357;14501.709965800836;13155.473781048651;13619.18284902909;14146;14172.220527870653;14642.633934151732;11215.327080375204;11386.772264554496;11806.291622502677;11840.111991600837;12046.397680116135;11418.371989540323;11687.590934317599;11992.580259690869;12158.209716368408;12386 11:16:19 INFO - PROCESS | 23381 | __end_tp_report 11:16:19 INFO - PROCESS | 23381 | __start_cc_report 11:16:19 INFO - PROCESS | 23381 | _x_x_mozilla_cycle_collect,1069 11:16:19 INFO - PROCESS | 23381 | __end_cc_report 11:16:19 INFO - PROCESS | 23381 | __startTimestamp1475604979566__endTimestamp 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | ------- Summary: start ------- 11:16:19 INFO - PROCESS | 23381 | Number of tests: 6 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#0] dojo.html Cycles:165 Average:5668.44 Median:5877.82 stddev:663.20 (11.3%) stddev-sans-first:634.32 11:16:19 INFO - PROCESS | 23381 | Values: 3117.5 3136.5 3151.1 3172.8 3190.5 5554.7 5644.9 5663.7 5678.2 5686.9 5754.2 5822.1 5827.3 5832.7 5871.3 5201.8 5229.3 5246.9 5268.0 5308.8 5101.9 5108.9 5325.7 5333.5 5368.7 5086.7 5166.6 5233.3 5236.7 5238.5 5129.5 5147.2 5200.7 5221.1 5221.7 5147.1 5245.7 5252.7 5255.7 5284.0 5550.1 5602.3 5606.6 5708.9 5728.5 6056.7 6065.3 6069.6 6079.9 6086.5 6168.7 6189.8 6219.1 6224.4 6225.0 5548.1 5600.0 5600.7 5807.3 5823.6 6113.5 6117.9 6141.2 6259.1 6260.6 5993.8 6012.2 6013.2 6022.3 6049.2 5960.6 6017.4 6097.3 6102.8 6104.8 5931.9 5977.3 5989.3 6023.5 6071.2 5994.5 6047.2 6061.3 6064.9 6097.7 4536.0 4617.1 4644.0 4656.4 4676.6 4046.2 4071.9 4110.0 4112.7 4173.7 5813.5 5818.9 5820.5 5820.7 5823.8 6100.6 6112.5 6115.1 6116.3 6125.5 5727.2 5784.4 5795.1 5852.4 5856.8 5357.2 5373.7 5374.4 5379.6 5396.2 6339.1 6363.1 6422.5 6423.2 6426.9 5931.9 5982.0 6096.1 6158.6 6226.5 6299.7 6404.6 6407.9 6419.2 6419.8 6043.8 6059.1 6078.4 6083.5 6085.7 5860.3 5947.6 6038.8 6187.8 6203.7 5858.4 5931.7 5985.6 6002.2 6024.8 5962.5 5979.4 5982.1 5992.1 5999.2 5641.5 5759.1 5918.6 5920.6 5922.3 5905.8 5951.4 5962.3 5991.2 6021.8 5824.8 5860.4 5868.0 5877.8 5879.4 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#1] ext.html Cycles:180 Average:63689.12 Median:22241.66 stddev:130868.55 (588.4%) stddev-sans-first:131149.95 11:16:19 INFO - PROCESS | 23381 | Values: 599.7 626.6 649.4 654.5 657.8 34785.0 46048.3 46278.3 46348.5 46377.1 47288.3 47751.3 47772.8 47792.0 47812.5 8467.9 9269.5 9438.8 9445.6 9449.4 8396.4 11090.7 11326.4 11365.5 11601.7 11267.4 11312.8 11326.4 11329.0 11329.3 8548.0 8765.7 11110.0 11193.9 11197.4 10285.3 10497.5 10514.6 10525.2 10533.3 44145.6 44634.8 44661.0 44669.8 44699.6 3878.6 3950.5 3989.5 4079.3 4315.3 34315.8 34326.3 34384.5 34577.7 34802.5 4664.4 4684.0 4777.3 4780.2 4861.8 267161.0 267193.0 268473.0 269194.0 351488.2 62205.7 62347.4 62370.4 62579.7 62582.0 40493.8 41153.0 41407.4 43340.6 64986.4 19437.2 19608.9 19633.1 19638.9 19648.6 13767.6 14008.6 14209.2 14975.3 15101.5 19659.3 20374.2 20402.0 20450.8 20458.7 7209.6 7376.0 7410.0 7443.9 7567.7 1034.3 1057.5 1067.5 1079.7 1169.8 33720.7 34132.0 34243.7 34339.0 34384.7 1133.7 1139.1 1168.8 1183.9 1207.6 17899.4 18026.9 18061.8 18070.4 18087.9 634050.0 642536.0 643536.0 643858.0 644268.0 61267.4 61789.4 61859.0 61878.7 62046.4 1294.8 1300.1 1393.3 1402.3 1450.5 32731.8 34827.3 35142.5 35362.5 35547.5 52157.2 52210.0 52782.7 52886.2 52945.0 477162.0 478609.0 478852.0 479160.0 480176.0 30738.7 31522.4 31741.7 33019.7 33023.0 49823.0 50707.5 50917.0 50981.0 52060.7 42107.4 42775.8 43038.4 43677.3 43943.8 42706.8 43228.0 43266.5 44006.1 44230.8 41958.6 42519.1 42819.8 42870.8 43556.1 36836.6 38633.8 39425.8 39652.0 39726.4 29089.0 29155.9 29193.1 29218.4 29595.9 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#2] jquery.html Cycles:180 Average:30823.07 Median:12102.70 stddev:85288.40 (704.7%) stddev-sans-first:85497.06 11:16:19 INFO - PROCESS | 23381 | Values: 394.4 419.6 430.4 433.7 441.9 15745.3 19705.6 22012.6 22161.0 22448.8 19112.1 19600.1 19787.8 20159.4 20693.5 5003.9 5558.3 5734.6 5741.7 5746.2 5657.2 6281.2 6322.9 6325.1 6325.4 5943.9 6215.0 6281.2 6285.5 6286.5 6215.5 6237.9 6248.7 6251.1 6256.2 5858.4 6090.2 6141.1 6158.4 6165.0 15431.8 15676.5 20536.3 25309.4 25490.9 2463.3 2533.5 2559.6 2805.3 2870.9 11085.4 11298.8 11550.1 11738.1 13411.9 2045.3 2112.3 2130.1 2167.5 2192.8 91586.0 95339.0 97178.5 97920.0 98178.5 10665.1 11533.7 11632.4 11852.1 12009.6 15475.2 15699.8 16246.0 16280.3 16283.3 8413.2 8592.0 8998.6 9010.4 9074.3 8702.2 8733.9 8814.0 8911.3 8961.9 5152.8 5198.1 5219.1 5232.0 5295.5 2065.3 2098.9 2105.7 2231.6 2234.2 929.9 1002.4 1021.3 1021.5 1079.3 20273.3 20357.2 20361.7 20433.2 20775.2 1033.3 1033.9 1035.3 1092.4 1119.5 11084.7 12152.5 12205.8 12238.3 12473.2 464708.0 476247.0 529502.0 546354.0 551517.0 100093.5 102443.5 103306.0 104343.0 110033.0 1072.1 1082.2 1120.8 1122.8 1166.1 18567.7 18888.2 18953.9 19111.7 19126.7 40654.8 45797.5 46454.3 46863.5 47353.0 51453.2 58285.7 58813.4 59430.4 60620.7 7915.2 8572.4 8574.1 8713.8 9107.6 8582.1 10279.6 12041.0 13885.1 14565.6 11840.5 11876.6 12139.8 12184.1 12296.5 12044.5 12114.6 12171.9 12313.7 12499.0 12264.1 12424.3 12505.2 12573.2 12765.6 8448.0 8635.1 8710.4 8876.1 8957.9 11467.8 11487.7 11537.6 11651.7 11709.4 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#3] mootools.html Cycles:180 Average:6393.08 Median:491.20 stddev:3705.40 (754.4%) stddev-sans-first:3696.87 11:16:19 INFO - PROCESS | 23381 | Values: 1410.8 1574.9 1579.5 1776.6 1868.7 8525.6 9490.2 9755.1 9774.0 10109.6 9766.0 9834.1 9844.9 9851.1 9854.4 2579.9 2604.9 2611.9 2613.2 2613.6 2517.3 2564.3 2566.1 2567.6 2567.9 2507.2 2542.6 2612.8 2618.5 2618.6 2522.1 2527.8 2542.9 2551.1 2559.0 2441.1 2449.3 2478.0 2479.8 2483.4 9357.8 9816.2 9920.2 9937.9 9944.9 5708.2 5868.6 5981.7 5986.8 5987.4 3634.9 3680.2 3700.8 3707.9 3727.8 1278.1 1285.5 1301.8 1333.4 1345.3 13970.6 14116.2 14128.4 14185.6 14242.8 5119.8 5188.6 5337.7 5341.1 5422.3 11953.0 11955.3 11964.5 11982.8 11992.2 5855.6 5916.2 5919.1 5921.9 5944.9 4439.6 4623.9 4824.9 5359.7 5391.6 4457.6 4496.8 4556.6 4584.3 4616.8 1422.3 1436.9 1438.7 1457.2 1459.5 857.3 882.8 912.0 958.7 1017.3 6379.7 6464.1 6490.3 6511.1 6586.9 491.0 491.4 503.5 508.3 519.5 4287.0 4400.0 4446.7 4462.2 4466.2 11548.4 11666.7 11739.2 11753.4 11756.6 11606.1 11678.2 11711.9 11792.9 12147.0 8665.0 8868.3 8877.3 8906.9 8934.0 6644.4 6803.6 6914.5 6959.1 7025.1 11125.8 11422.5 11484.7 11485.7 11672.0 10313.5 10384.1 11740.5 11790.5 11823.6 8340.8 8618.8 8928.8 8930.5 8932.2 9080.7 9090.8 9113.6 9134.1 9193.2 8360.5 8431.2 8485.6 8602.7 8697.9 8046.9 8170.8 8276.4 8363.1 8465.4 7515.1 7587.0 7605.1 7711.9 7716.3 5363.2 5396.1 5437.9 5440.9 5502.1 5526.3 5559.3 5617.2 5626.5 5721.9 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#4] prototype.html Cycles:180 Average:4756.60 Median:5344.26 stddev:1384.05 (25.9%) stddev-sans-first:1347.91 11:16:19 INFO - PROCESS | 23381 | Values: 354.1 359.7 361.0 364.0 366.4 5520.4 5527.9 5530.6 5538.5 5595.2 5158.3 5430.6 5449.5 5476.0 5504.7 3784.0 4243.3 4248.2 4311.0 4325.9 4291.0 4299.8 4299.9 4303.2 4311.4 4297.2 4298.0 4327.4 4342.0 4361.5 4065.8 4120.6 4322.8 4336.9 4354.8 3868.7 3872.0 3875.6 3886.5 3912.7 5314.7 5333.2 5347.6 5363.5 5370.8 4790.4 4915.3 4964.0 4992.2 5000.9 5701.7 5710.8 5711.8 5715.0 5721.8 4278.0 4280.6 4291.2 4295.6 4338.4 5607.0 5612.6 5795.4 5934.6 6031.2 4139.5 4246.6 4259.5 4264.6 4289.5 4301.7 4334.9 4338.2 4342.4 4347.3 4669.8 4872.8 4879.0 4940.8 4950.2 5735.5 5748.6 5768.2 5770.1 5798.9 1488.2 1502.5 1502.7 1521.6 1523.5 916.2 959.5 968.2 969.1 984.8 4918.2 4956.4 4965.7 4966.3 4970.4 5146.2 5187.1 5205.6 5226.7 5230.9 4660.7 4902.0 4967.8 4972.7 5045.8 2760.0 2762.9 2771.0 2775.0 2791.3 5343.0 5345.5 5346.3 5366.2 5403.3 5283.2 5300.6 5622.9 5980.9 6018.6 6052.8 6059.2 6059.8 6082.7 6105.8 5606.2 5904.5 5918.3 5926.5 5949.3 5778.2 5847.5 5862.0 5888.6 5899.9 5892.3 5999.0 6019.8 6062.6 6139.0 4077.9 4172.5 4235.4 4278.0 4289.6 5745.9 5905.2 5939.5 5961.3 5980.3 5696.9 5711.9 5719.7 5765.2 5788.5 5681.6 5711.6 5713.3 5718.3 5750.3 5459.5 5645.4 5660.3 5668.5 5738.5 5698.2 5704.3 5715.8 5730.8 5745.7 5649.2 5659.2 5680.9 5692.9 5699.3 11:16:19 INFO - PROCESS | 23381 | 11:16:19 INFO - PROCESS | 23381 | [#5] yui.html Cycles:180 Average:22378.36 Median:3596.94 stddev:32255.68 (896.8%) stddev-sans-first:32305.41 11:16:19 INFO - PROCESS | 23381 | Values: 782.7 809.0 822.3 886.3 950.0 16476.9 17005.1 17291.3 17378.3 17417.2 15323.8 15544.0 15564.3 15622.4 15656.4 706.8 714.9 850.7 865.2 867.5 864.9 868.6 868.8 868.8 869.6 914.7 922.3 923.0 924.3 924.7 754.6 766.3 889.4 894.8 900.5 668.9 676.2 676.4 676.9 677.0 15388.1 15404.5 15432.9 15461.5 15478.8 15315.5 15412.5 15471.0 15560.0 15914.1 14163.9 14305.2 14362.1 14707.2 15051.8 4561.5 4578.0 4634.0 4666.2 4679.5 88258.6 88572.1 88595.6 89047.0 89508.0 11537.9 11811.7 12016.7 12032.7 12101.8 23491.3 23552.3 23577.0 23602.5 23606.2 8903.7 8928.9 9189.6 9298.3 9510.3 5013.7 5116.8 5175.7 5180.4 5363.4 3528.3 3665.6 3665.9 3688.6 3690.0 680.4 709.5 710.4 711.2 722.0 793.8 827.4 840.6 842.6 861.3 10386.9 10802.8 11065.6 11363.8 11734.9 686.8 718.4 739.7 801.9 821.0 5180.2 5276.4 5353.4 5378.1 5394.6 112866.4 115131.3 118919.0 121004.4 123012.4 104042.0 105997.5 108373.0 108566.0 108924.0 91064.0 92903.0 95165.5 96190.5 97332.0 10154.6 10288.3 10417.3 10425.3 10532.5 50855.5 52256.5 53393.0 53808.5 55262.7 78304.6 78895.8 81670.0 81728.2 85205.6 12792.1 13013.2 13141.7 13296.7 13333.7 12898.6 13076.4 13253.0 13484.1 13902.3 13786.2 13999.5 14251.6 14276.4 14429.8 13899.2 14308.3 14415.9 14432.9 14501.7 13155.5 13619.2 14146.0 14172.2 14642.6 11215.3 11386.8 11806.3 11840.1 12046.4 11418.4 11687.6 11992.6 12158.2 12386.0 11:16:19 INFO - PROCESS | 23381 | -------- Summary: end -------- 11:16:19 INFO - PROCESS | 23381 | 11:16:20 INFO - TEST-INFO | 23381: exit 0 11:16:20 INFO - TEST-OK | dromaeo_css | took 1113247ms 11:16:20 INFO - TEST-START | kraken 11:16:20 INFO - operating with platform_type : linux_ 11:16:20 INFO - Initialising browser for kraken test... 11:16:20 INFO - TEST-INFO | started process 23701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhKbcs/profile http://localhost:45796/getInfo.html) 11:16:24 INFO - PROCESS | 23701 | __metrics Screen width/height:1600/1200 11:16:24 INFO - PROCESS | 23701 | colorDepth:24 11:16:24 INFO - PROCESS | 23701 | Browser inner width/height: 1024/697 11:16:24 INFO - PROCESS | 23701 | __metrics 11:16:24 INFO - PROCESS | 23701 | 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" 11:16:24 INFO - PROCESS | 23701 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:24 INFO - PROCESS | 23701 | console.error: PushService: 11:16:24 INFO - PROCESS | 23701 | stateChangeProcessEnqueue: Error transitioning state 11:16:24 INFO - PROCESS | 23701 | UnknownError 11:16:25 INFO - TEST-INFO | 23701: exit 0 11:16:25 INFO - Browser initialized. 11:16:25 INFO - Running cycle 1/1 for kraken test... 11:16:25 INFO - TEST-INFO | started process 23797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhKbcs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:37 INFO - PROCESS | 23797 | RSS: Main: 144633856 11:16:37 INFO - PROCESS | 23797 | 11:16:39 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45796/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:40 INFO - PROCESS | 23797 | RSS: Main: 186191872 11:16:40 INFO - PROCESS | 23797 | 11:16:43 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45796/tests/kraken/driver.html?testName=audio-dft) 11:16:43 INFO - PROCESS | 23797 | RSS: Main: 175554560 11:16:43 INFO - PROCESS | 23797 | 11:16:46 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45796/tests/kraken/driver.html?testName=audio-fft) 11:16:47 INFO - PROCESS | 23797 | RSS: Main: 266506240 11:16:47 INFO - PROCESS | 23797 | 11:16:49 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45796/tests/kraken/driver.html?testName=audio-oscillator) 11:16:49 INFO - PROCESS | 23797 | RSS: Main: 172822528 11:16:49 INFO - PROCESS | 23797 | 11:16:52 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45796/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:52 INFO - PROCESS | 23797 | RSS: Main: 174493696 11:16:52 INFO - PROCESS | 23797 | 11:16:55 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45796/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:56 INFO - PROCESS | 23797 | RSS: Main: 210120704 11:16:56 INFO - PROCESS | 23797 | 11:16:59 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45796/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:00 INFO - PROCESS | 23797 | RSS: Main: 209252352 11:17:00 INFO - PROCESS | 23797 | 11:17:02 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45796/tests/kraken/driver.html?testName=json-parse-financial) 11:17:03 INFO - PROCESS | 23797 | RSS: Main: 209186816 11:17:03 INFO - PROCESS | 23797 | 11:17:04 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45796/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:05 INFO - PROCESS | 23797 | RSS: Main: 171040768 11:17:05 INFO - PROCESS | 23797 | 11:17:07 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:07 INFO - PROCESS | 23797 | RSS: Main: 179453952 11:17:07 INFO - PROCESS | 23797 | 11:17:09 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:10 INFO - PROCESS | 23797 | RSS: Main: 183373824 11:17:10 INFO - PROCESS | 23797 | 11:17:13 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:13 INFO - PROCESS | 23797 | RSS: Main: 183963648 11:17:13 INFO - PROCESS | 23797 | 11:17:16 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:16 INFO - PROCESS | 23797 | RSS: Main: 182382592 11:17:16 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | Cycle 1(1): loaded http://localhost:45796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45796/tests/kraken/driver.html?testName=ai-astar) 11:17:18 INFO - PROCESS | 23797 | RSS: Main: 233820160 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | __start_tp_report 11:17:18 INFO - PROCESS | 23797 | _x_x_mozilla_page_load 11:17:18 INFO - PROCESS | 23797 | _x_x_mozilla_page_load_details 11:17:18 INFO - PROCESS | 23797 | |i|pagename|runs| 11:17:18 INFO - PROCESS | 23797 | |0;ai-astar;112;112;112;111;111;112;111;110;112;111 11:17:18 INFO - PROCESS | 23797 | |1;audio-beat-detection;142;115;120;156;121;123;123;116;150;119 11:17:18 INFO - PROCESS | 23797 | |2;audio-dft;160;160;160;161;161;162;160;161;160;161 11:17:18 INFO - PROCESS | 23797 | |3;audio-fft;74;75;75;112;75;74;76;74;98;76 11:17:18 INFO - PROCESS | 23797 | |4;audio-oscillator;81;81;127;81;81;81;98;81;81;111 11:17:18 INFO - PROCESS | 23797 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;118;117;117 11:17:18 INFO - PROCESS | 23797 | |6;imaging-darkroom;146;145;145;145;145;145;146;146;145;146 11:17:18 INFO - PROCESS | 23797 | |7;imaging-desaturate;96;96;95;95;94;95;94;95;96;98 11:17:18 INFO - PROCESS | 23797 | |8;json-parse-financial;51;48;52;50;49;51;50;51;49;50 11:17:18 INFO - PROCESS | 23797 | |9;json-stringify-tinderbox;59;58;61;57;59;58;58;58;58;58 11:17:18 INFO - PROCESS | 23797 | |10;stanford-crypto-aes;73;73;82;73;80;74;81;74;73;73 11:17:18 INFO - PROCESS | 23797 | |11;stanford-crypto-ccm;124;121;121;127;121;115;117;123;158;128 11:17:18 INFO - PROCESS | 23797 | |12;stanford-crypto-pbkdf2;157;152;150;153;154;154;154;152;154;153 11:17:18 INFO - PROCESS | 23797 | |13;stanford-crypto-sha256-iterative;65;64;63;63;63;62;64;65;62;61 11:17:18 INFO - PROCESS | 23797 | __end_tp_report 11:17:18 INFO - PROCESS | 23797 | __start_cc_report 11:17:18 INFO - PROCESS | 23797 | _x_x_mozilla_cycle_collect,1568 11:17:18 INFO - PROCESS | 23797 | __end_cc_report 11:17:18 INFO - PROCESS | 23797 | __startTimestamp1475605038755__endTimestamp 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | ------- Summary: start ------- 11:17:18 INFO - PROCESS | 23797 | Number of tests: 14 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:17:18 INFO - PROCESS | 23797 | Values: 112.0 112.0 112.0 111.0 111.0 112.0 111.0 110.0 112.0 111.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:123.00 stddev:14.98 (12.2%) stddev-sans-first:15.07 11:17:18 INFO - PROCESS | 23797 | Values: 142.0 115.0 120.0 156.0 121.0 123.0 123.0 116.0 150.0 119.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 11:17:18 INFO - PROCESS | 23797 | Values: 160.0 160.0 160.0 161.0 161.0 162.0 160.0 161.0 160.0 161.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:13.14 (17.5%) stddev-sans-first:13.70 11:17:18 INFO - PROCESS | 23797 | Values: 74.0 75.0 75.0 112.0 75.0 74.0 76.0 74.0 98.0 76.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.00 stddev:16.47 (20.3%) stddev-sans-first:17.12 11:17:18 INFO - PROCESS | 23797 | Values: 81.0 81.0 127.0 81.0 81.0 81.0 98.0 81.0 81.0 111.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:17:18 INFO - PROCESS | 23797 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:17:18 INFO - PROCESS | 23797 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:1.17 (1.2%) stddev-sans-first:1.22 11:17:18 INFO - PROCESS | 23797 | Values: 96.0 96.0 95.0 95.0 94.0 95.0 94.0 95.0 96.0 98.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.50 stddev:1.20 (2.4%) stddev-sans-first:1.22 11:17:18 INFO - PROCESS | 23797 | Values: 51.0 48.0 52.0 50.0 49.0 51.0 50.0 51.0 49.0 50.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 11:17:18 INFO - PROCESS | 23797 | Values: 59.0 58.0 61.0 57.0 59.0 58.0 58.0 58.0 58.0 58.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.00 stddev:3.78 (5.1%) stddev-sans-first:3.89 11:17:18 INFO - PROCESS | 23797 | Values: 73.0 73.0 82.0 73.0 80.0 74.0 81.0 74.0 73.0 73.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:123.50 stddev:12.09 (9.8%) stddev-sans-first:12.82 11:17:18 INFO - PROCESS | 23797 | Values: 124.0 121.0 121.0 127.0 121.0 115.0 117.0 123.0 158.0 128.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:154.00 stddev:1.83 (1.2%) stddev-sans-first:1.36 11:17:18 INFO - PROCESS | 23797 | Values: 157.0 152.0 150.0 153.0 154.0 154.0 154.0 152.0 154.0 153.0 11:17:18 INFO - PROCESS | 23797 | 11:17:18 INFO - PROCESS | 23797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.32 (2.1%) stddev-sans-first:1.22 11:17:18 INFO - PROCESS | 23797 | Values: 65.0 64.0 63.0 63.0 63.0 62.0 64.0 65.0 62.0 61.0 11:17:18 INFO - PROCESS | 23797 | -------- Summary: end -------- 11:17:18 INFO - PROCESS | 23797 | 11:17:19 INFO - TEST-INFO | 23797: exit 0 11:17:19 INFO - TEST-OK | kraken | took 59443ms 11:17:19 INFO - SUITE-END | took 1172s 11:17:19 INFO - Completed test suite (00:19:32) 11:17:19 INFO - javascript benchmark 11:17:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.5011998080304, 3136.5452009458627, 3151.1176870476274, 3172.8413579321027, 3190.505471651895, 5554.722263886804, 5644.943550564493, 5663.745131469083, 5678.176664383656, 5686.857828554278, 5754.16564598134, 5822.126680997852, 5827.329857066438, 5832.708364581765, 5871.266091738533, 5201.791928322863, 5229.267902493654, 5246.947530524703, 5267.973660131694, 5308.840734777963, 5101.923471147936, 5108.948910510884, 5325.653832500875, 5333.466653334654, 5368.70472124033, 5086.745662716868, 5166.612504062192, 5233.293505376782, 5236.738163091849, 5238.52853243208, 5129.512696293846, 5147.202183661539, 5200.6879587224885, 5221.06020916235, 5221.738913054332, 5147.073526765181, 5245.659032162897, 5252.65857719247, 5255.737213139328, 5284.048871203182, 5550.056490396642, 5602.327720673505, 5606.55147588192, 5708.914366284509, 5728.484436400744, 6056.697165141725, 6065.302490213594, 6069.6054756441135, 6079.939200607982, 6086.543509236825, 6168.684282482795, 6189.81430557084, 6219.09823075656, 6224.408681175281, 6225.0, 5548.0845660466375, 5600.047991841397, 5600.691961942132, 5807.30312362515, 5823.592348535604, 6113.541484388688, 6117.855613428804, 6141.1791743482045, 6259.0924315973925, 6260.561760676709, 5993.790217342372, 6012.218411606551, 6013.218281623448, 6022.281844386149, 6049.153118563405, 5960.612560183574, 6017.428344307284, 6097.298810636745, 6102.8169154924535, 6104.847378815565, 5931.9406805931385, 5977.252843394575, 5989.311229208697, 6023.518118550505, 6071.210742603434, 5994.490468310242, 6047.244094488189, 6061.3029501607, 6064.9090263646085, 6097.695115244309, 4536.047430039728, 4617.1227466781875, 4643.976780116078, 4656.3946686930485, 4676.625869930397, 4046.2109888572036, 4071.91856162881, 4110.013596736761, 4112.691548133902, 4173.686973477002, 5813.476787089182, 5818.94181058184, 5820.505257053198, 5820.738066787005, 5823.82528524145, 6100.603460775035, 6112.51099912006, 6115.113308570232, 6116.327204007555, 6125.479334256638, 5727.198192253088, 5784.363719990798, 5795.1017592273265, 5852.356240813507, 5856.765729370777, 5357.19642053695, 5373.650712703662, 5374.381946076173, 5379.623426360117, 5396.163594642758, 6339.112524246517, 6363.140975968277, 6422.4862011039, 6423.197100362455, 6426.8714625707225, 5931.9110213345975, 5982.0, 6096.055111457731, 6158.630482171084, 6226.470749986302, 6299.716512757029, 6404.551681382259, 6407.903881441689, 6419.165508483868, 6419.839504012437, 6043.848903777441, 6059.091136329585, 6078.3617720138745, 6083.482903953213, 6085.665288409003, 5860.2967643883, 5947.6431414115295, 6038.75844966214, 6187.84530386744, 6203.689815509116, 5858.355580886185, 5931.703414829328, 5985.610935289193, 6002.219711437485, 6024.819255422344, 5962.493188079062, 5979.372165922689, 5982.0727787193055, 5992.101184822312, 5999.1601175836295, 5641.464060914206, 5759.078547432391, 5918.556108291809, 5920.555958303231, 5922.289325280994, 5905.822825315247, 5951.404859514188, 5962.284525856925, 5991.221141251609, 6021.819345419644, 5824.767009319579, 5860.355360910382, 5867.970660146672, 5877.823665290048, 5879.382664820303], "value": 5621.183892081386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7151353107274, 626.5582764151274, 649.3668673043783, 654.52546903495, 657.8026592022392, 34785.0, 46048.309275360894, 46278.305825412644, 46348.53651463484, 46377.07245855081, 47288.290675639895, 47751.283730744064, 47772.76113619427, 47792.0, 47812.52187478124, 8467.915320846774, 9269.490178040205, 9438.764030899214, 9445.622175113022, 9449.385789923668, 8396.370272229577, 11090.667279981613, 11326.377049262288, 11365.488553015135, 11601.709957251052, 11267.380294083821, 11312.773744525104, 11326.43367831605, 11329.0, 11329.320240785539, 8547.95726021366, 8765.693200737944, 11110.0, 11193.888061119365, 11197.440127993608, 10285.331453455501, 10497.475126243657, 10514.631987880464, 10525.210609204263, 10533.26267161299, 44145.55854441447, 44634.77682611599, 44661.0, 44669.77665111654, 44699.55300446986, 3878.612138786127, 3950.545687245975, 3989.5212574491247, 4079.3473044313064, 4315.331123675835, 34315.828420857986, 34326.31347373063, 34384.484232736526, 34577.65422345769, 34802.47796283058, 4664.416947881515, 4683.95316046842, 4777.307290442901, 4780.163471392492, 4861.829835955725, 267161.0, 267193.0, 268473.0, 269194.0, 351488.2425587881, 62205.68897155485, 62347.376526234155, 62370.376296237366, 62579.6871015642, 62582.0, 40493.797531012155, 41153.0, 41407.378889316686, 43340.56659433428, 64986.35013649898, 19437.22251109968, 19608.90195549013, 19633.116509757096, 19638.90180549088, 19648.60702785936, 13767.586972390643, 14008.649783755487, 14209.218492982985, 14975.251237438302, 15101.546953591409, 19659.311924082587, 20374.18503259853, 20401.979901004892, 20450.77295362283, 20458.693119603216, 7209.567425954459, 7375.963120184472, 7410.0, 7443.925560744432, 7567.735129270559, 1034.3225187502198, 1057.5399701130034, 1067.5462928255615, 1079.7138758229075, 1169.7894379011689, 33720.66279337224, 34131.98281458298, 34243.657563424546, 34339.0, 34384.65615343865, 1133.727905302738, 1139.0887290167998, 1168.8480497535436, 1183.893449589541, 1207.5532053140394, 17899.37352192693, 18026.90986545059, 18061.819381806275, 18070.3675371364, 18087.909560452114, 634050.0, 642536.0, 643536.0, 643858.0, 644268.0, 61267.38732612706, 61789.38210617836, 61859.0, 61878.690606546676, 62046.37953620406, 1294.7863602505481, 1300.0574583427128, 1393.2546087842954, 1402.2848347342724, 1450.5358285348586, 32731.836340818143, 34827.303453930275, 35142.472862906565, 35362.46956295709, 35547.466787997684, 52157.21764173616, 52210.0, 52782.736086319324, 52886.20670690019, 52945.0, 477162.0, 478609.0, 478852.0, 479160.0, 480176.0, 30738.692613074476, 31522.369552609278, 31741.682583174796, 33019.66980330166, 33023.00930972075, 49823.0, 50707.492925071754, 50917.0, 50981.0, 52060.73969630279, 42107.36838947357, 42775.7861210692, 43038.35442468303, 43677.344839826794, 43943.78028109839, 42706.78646606747, 43228.0, 43266.4713544915, 44006.11987760291, 44230.77884610556, 41958.58041419669, 42519.14961700811, 42819.78590107154, 42870.78564607157, 43556.12887742291, 36836.631633684396, 38633.80683096567, 39425.80287098546, 39652.0, 39726.40410393904, 29089.0, 29155.85422072876, 29193.124206273846, 29218.415631687672, 29595.85202073976], "value": 21482.04185445272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.42807928503674, 419.59928268503603, 430.39744357898945, 433.67474394204345, 441.93370994350846, 15745.291461884213, 19705.5650992769, 22012.559748805015, 22161.0, 22448.775512244894, 19112.13995370208, 19600.117994690238, 19787.802121978777, 20159.395218143443, 20693.482662933435, 5003.949960500385, 5558.305211848529, 5734.598578099534, 5741.712914354265, 5746.224259724925, 5657.151427285919, 6281.246250449953, 6322.873542529147, 6325.114483972247, 6325.399087086719, 5943.910841337383, 6215.0366693162405, 6281.183446151994, 6285.497160227171, 6286.528510361718, 6215.471684906788, 6237.875242495124, 6248.7188076536895, 6251.12484252205, 6256.1866957295715, 5858.443447872445, 6090.208272924491, 6141.078838174265, 6158.353372895871, 6164.96917515414, 15431.768523472158, 15676.529704108782, 20536.281230157023, 25309.367265818317, 25490.872545637154, 2463.322586288785, 2533.480636469538, 2559.5648739714293, 2805.3126983888874, 2870.942581148365, 11085.390303533302, 11298.830517542243, 11550.075993920465, 11738.06095512357, 13411.932940335237, 2045.263705066175, 2112.3346145964124, 2130.084063852543, 2167.479804846841, 2192.8355373347063, 91586.0, 95339.0, 97178.51410742971, 97920.0, 98178.50910745472, 10665.146788256921, 11533.653990380302, 11632.360220187802, 11852.051835853112, 12009.579664711693, 15475.226238688021, 15699.764503532457, 16246.0, 16280.348786048662, 16283.267252973408, 8413.158684131538, 8591.957040214884, 8998.55007249635, 9010.369274150878, 9074.31942604294, 8702.173293537104, 8733.912660873437, 8814.030456649763, 8911.287097032222, 8961.865572016424, 5152.819651312186, 5198.142306519382, 5219.060569097599, 5232.0, 5295.4969277918535, 2065.2565076572423, 2098.9085675448987, 2105.747310322771, 2231.6317807561895, 2234.240358278193, 929.869818225449, 1002.4035698759227, 1021.3004092196869, 1021.5352014833232, 1079.255313833468, 20273.29043483471, 20357.185712571627, 20361.694574581394, 20433.182672693223, 20775.168993240404, 1033.261218228955, 1033.8604288420968, 1035.29082578434, 1092.4264761000538, 1119.4738472917716, 11084.722881927855, 12152.5138994441, 12205.816912746315, 12238.265704057785, 12473.189242699196, 464708.0, 476247.0, 529502.0, 546354.0, 551517.0, 100093.49953250187, 102443.48778256061, 103306.0, 104343.0, 110033.0, 1072.0940805019745, 1082.199172612277, 1120.8206686930052, 1122.820348744197, 1166.1312322319925, 18567.721484177477, 18888.244470221038, 18953.905230474313, 19111.713324299868, 19126.713099303244, 40654.79672601618, 45797.54202457933, 46454.30318545292, 46863.531364685914, 47353.0, 51453.22820157775, 58285.708571456875, 58813.41186588079, 59430.40569594422, 60620.696896515234, 7915.248051435105, 8572.35707321941, 8574.056853745959, 8713.825723485368, 9107.635694572144, 8582.09887961755, 10279.640212592523, 12041.0, 13885.097468664504, 14565.563033109023, 11840.526378944745, 11876.584319548774, 12139.75720485603, 12184.147109702235, 12296.508139674313, 12044.457999390224, 12114.5834369064, 12171.914042978511, 12313.692157696129, 12499.0, 12264.141510094565, 12424.316662583284, 12505.187162834387, 12573.245605263714, 12765.553205637758, 8448.0, 8635.136486351315, 8710.390272680852, 8876.112388761072, 8957.865632015655, 11467.770644587228, 11487.712807179887, 11537.596184133516, 11651.650450486499, 11709.414529273672], "value": 9772.436184468846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.7883817427391, 1574.9291281892317, 1579.526142157353, 1776.564741638298, 1868.6636405447014, 8525.573721313933, 9490.193333566647, 9755.073268039543, 9774.0, 10109.595616175362, 9765.951170244156, 9834.114929656329, 9844.852327215098, 9851.113399794018, 9854.359466634663, 2579.935501612456, 2604.895804167831, 2611.8955241790304, 2613.2421597736634, 2613.607958806185, 2517.307740371394, 2564.3204550794053, 2566.114690431798, 2567.6405303257557, 2567.9486410271875, 2507.2352932355716, 2542.5677634802128, 2612.804039697021, 2618.541755192843, 2618.646482724827, 2522.1046528482398, 2527.848329100251, 2542.9237122886343, 2551.132614910939, 2558.961615575768, 2441.1333976438464, 2449.3019489445423, 2477.9876100619563, 2479.82641215115, 2483.379155211197, 9357.76605584859, 9816.214702823829, 9920.206383489376, 9937.850932236022, 9944.900550994542, 5708.172315014342, 5868.559858010623, 5981.671008094553, 5986.760529578812, 5987.371326010793, 3634.872779452733, 3680.190358121236, 3700.777953322809, 3707.888763337104, 3727.7576957497677, 1278.0670110819062, 1285.505080543988, 1301.8372703412074, 1333.4199623163954, 1345.307166809094, 13970.580882573538, 14116.153030818185, 14128.434862605483, 14185.574432767033, 14242.786358204636, 5119.846404607868, 5188.584913206934, 5337.6797392156595, 5341.145416733304, 5422.267993820863, 11953.043756499459, 11955.282683039046, 11964.521419143137, 11982.820257696141, 11992.160548761678, 5855.59010869235, 5916.230889984275, 5919.052951527735, 5921.904447677193, 5944.851378715567, 4439.556044395535, 4623.884402889955, 4824.903501929942, 5359.705216213146, 5391.56867450603, 4457.576530229623, 4496.775161241925, 4556.589906908394, 4584.312353146988, 4616.822710208875, 1422.267532220907, 1436.8634979676915, 1438.7050654615778, 1457.227669335254, 1459.5037687186407, 857.2713193785357, 882.761654353321, 911.9603651836911, 958.7363475044418, 1017.308230403318, 6379.681015949184, 6464.127342808661, 6490.318516555788, 6511.088447617338, 6586.907110922378, 490.9705417674951, 491.4323955831021, 503.4512381504178, 508.3239291741974, 519.4545726986725, 4286.957130428656, 4400.0, 4446.688731788744, 4462.174497717932, 4466.173757854807, 11548.364839933884, 11666.70833229176, 11739.23694959825, 11753.353565553805, 11756.58851940195, 11606.071514278838, 11678.182527223184, 11711.88288117125, 11792.94103529494, 12147.0, 8664.95667521671, 8868.33487488441, 8877.289816814638, 8906.910930890737, 8933.955330223438, 6644.435223006099, 6803.557768745016, 6914.481413893877, 6959.130108736408, 7025.121859767529, 11125.833112503156, 11422.485988130387, 11484.712882178012, 11485.712857178303, 11672.0, 10313.484325783531, 10384.117350025332, 11740.530378785095, 11790.528378865092, 11823.645290641294, 8340.791480213044, 8618.827623447622, 8928.776780580538, 8930.508822014592, 8932.240759535252, 9080.682176123804, 9090.772730681521, 9113.635454581743, 9134.086591340812, 9193.218576421079, 8360.45657032291, 8431.15688431152, 8485.575721214038, 8602.655893764178, 8697.91302086971, 8046.919530804851, 8170.754877353451, 8276.379271554779, 8363.121872203574, 8465.449745766506, 7515.135759387522, 7587.013688220496, 7605.125410577854, 7711.922880771345, 7716.305532501877, 5363.249145119765, 5396.0556902542685, 5437.927570922416, 5440.891182176413, 5502.119660854244, 5526.336839579276, 5559.27729395176, 5617.241672374341, 5626.493615574454, 5721.856953576027], "value": 5002.258393814771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.1217779905833, 359.74817627660644, 361.0486368419218, 364.03167574252495, 366.4082506751597, 5520.392756796759, 5527.917081243784, 5530.64947397356, 5538.4738449847255, 5595.160725891118, 5158.252053452247, 5430.647007944491, 5449.482299181582, 5475.972620136894, 5504.697241651707, 3784.0, 4243.32106862902, 4248.150369926027, 4310.956890431087, 4325.940144664546, 4290.97854510727, 4299.849505267316, 4299.892502687442, 4303.24693178694, 4311.426329389766, 4297.183535128332, 4297.978510107445, 4327.446806384232, 4341.978290108561, 4361.498427680825, 4065.8170382332864, 4120.619592436522, 4322.82708691652, 4336.913261734748, 4354.804033818486, 3868.6905047596406, 3872.0, 3875.61243875613, 3886.4947556817715, 3912.726109172359, 5314.654547454442, 5333.2266821310695, 5347.6256662033675, 5363.517283444508, 5370.812021579226, 4790.42514898211, 4915.3364295819965, 4963.975180124113, 4992.226204938204, 5000.874978125539, 5701.714914254312, 5710.77156913723, 5711.828645140652, 5714.9714251428895, 5721.7711291548285, 4278.0, 4280.550542193056, 4291.163223171483, 4295.591918767712, 4338.392625032498, 5607.0, 5612.607117501777, 5795.391483894173, 5934.5845790794665, 6031.215941927565, 4139.516290225841, 4246.596573325529, 4259.531451540328, 4264.637505812041, 4289.463817022872, 4301.720388174758, 4334.869953901388, 4338.175746608134, 4342.435483387139, 4347.282698354799, 4669.836555720533, 4872.78072486739, 4878.9512104878495, 4940.802367905316, 4950.158473059589, 5735.451428114386, 5748.626339287933, 5768.192453056576, 5770.067027545819, 5798.855028624318, 1488.2261224163374, 1502.4516051641071, 1502.7445334293197, 1521.6043828604643, 1523.4820161145265, 916.1800188831093, 959.4866746290701, 968.1673760565908, 969.0938972061005, 984.7587341101332, 4918.163912134874, 4956.3804524434445, 4965.652404331662, 4966.279889416014, 4970.378702662168, 5146.228065790161, 5187.0922588546855, 5205.6465319017325, 5226.70717448013, 5230.92153617696, 4660.673752837337, 4901.975490122598, 4967.826126085642, 4972.701637901738, 5045.798168073309, 2760.0, 2762.9171124866284, 2770.9747393464545, 2774.9881336031217, 2791.260316016257, 5343.0, 5345.518903298722, 5346.278252435949, 5366.202322222021, 5403.2705584746345, 5283.233931079972, 5300.628955973122, 5622.91565626516, 5980.910286345708, 6018.578699491081, 6052.848678782978, 6059.182010428536, 6059.818205453844, 6082.695865206811, 6105.84735381619, 5606.215129881738, 5904.468597826216, 5918.260217472816, 5926.4666180044005, 5949.25634295713, 5778.191053252464, 5847.462285317321, 5862.0, 5888.587798854039, 5899.91150132757, 5892.322382926019, 5998.970005149947, 6019.849503762441, 6062.605930614496, 6138.969305153446, 4077.8776636700945, 4172.457580514514, 4235.449391579075, 4277.978610106929, 4289.592488713567, 5745.8563535911935, 5905.202797622266, 5939.46544810969, 5961.314448838266, 5980.312264089685, 5696.943030569641, 5711.857203569944, 5719.714014299185, 5765.1928729977, 5788.507976822018, 5681.573881958787, 5711.628744131618, 5713.314402271754, 5718.25662663851, 5750.338711048283, 5459.481349271813, 5645.435456454322, 5660.264165658438, 5668.546516278605, 5738.512226460798, 5698.173764803997, 5704.258446401941, 5715.799682066812, 5730.770769169187, 5745.74144163522, 5649.20911072442, 5659.151127330933, 5680.886382272414, 5692.914606280992, 5699.287589051369], "value": 4322.591706891854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.729958164433, 808.987865182022, 822.3298012120122, 886.2644005475456, 950.0452045694076, 16476.91761541192, 17005.149742512887, 17291.30834766608, 17378.304867805273, 17417.216225269876, 15323.770143447857, 15544.0, 15564.299606517705, 15622.375104995815, 15656.373745050185, 706.8197609609542, 714.9320814522612, 850.7022542110243, 865.2213008292556, 867.5055218525443, 864.9091845356241, 868.6308318964446, 868.8045189832301, 868.8436081505326, 869.6173683579204, 914.7027216154743, 922.2575826459697, 922.9985465769648, 924.2929159193222, 924.6809850601531, 754.6340025087856, 766.264386189259, 889.4352086425102, 894.7807787092139, 900.4642237868458, 668.8829454845383, 676.2459857259121, 676.3980057748607, 676.8510927595921, 677.0318444624186, 15388.076715397112, 15404.46084387041, 15432.92283538575, 15461.458848940345, 15478.767818482731, 15315.540533784004, 15412.450780042842, 15471.0, 15560.0, 15914.124723140223, 14163.858361416356, 14305.213213273266, 14362.066465679802, 14707.19110448925, 15051.849481505154, 4561.498235194126, 4577.9542204577865, 4633.953660463386, 4666.2067448533835, 4679.461861885893, 88258.5587072067, 88572.11427885703, 88595.55702221511, 89047.0, 89508.0, 11537.88462115368, 11811.704707382385, 12016.699582510508, 12032.699182520508, 12101.757964840654, 23491.295261142193, 23552.293431197093, 23577.0, 23602.527949440915, 23606.173783917482, 8903.688370907117, 8928.910710892807, 9189.63241470347, 9298.279624410394, 9510.28672849539, 5013.724245166551, 5116.769745361467, 5175.715335656575, 5180.352455943007, 5363.436839131835, 3528.2767032758225, 3665.596784353719, 3665.890023299305, 3688.61269566697, 3689.9815500922323, 680.3978479046079, 709.4785332780402, 710.3819676881146, 711.2311948386059, 722.0216606498225, 793.7936136604525, 827.4332082523491, 840.5839109640767, 842.582921453872, 861.3410740783306, 10386.896131038744, 10802.837957430645, 11065.557377704963, 11363.772724545463, 11734.94132529332, 686.7767975408012, 718.3534818663245, 739.6523633892062, 801.903771547418, 820.9630566624517, 5180.248863914787, 5276.3932147802725, 5353.437889021597, 5378.085725426687, 5394.649347792381, 112866.43566782278, 115131.34220942759, 118919.0, 121004.39497802455, 123012.38493807474, 104042.0, 105997.47001265099, 108373.0, 108566.0, 108924.0, 91064.0, 92903.0, 95165.52417238009, 96190.51904740432, 97332.0, 10154.593816247267, 10288.2798204125, 10417.322874013165, 10425.270231083752, 10532.526036328536, 50855.49144508508, 52256.47743522516, 53393.0, 53808.46191538034, 55262.72368638131, 78304.60847695953, 78895.81656275275, 81670.0, 81728.18271817206, 85205.57397212974, 12792.104552681223, 13013.21920684762, 13141.671458213621, 13296.667583310495, 13333.66665833362, 12898.613041608767, 13076.411561479566, 13253.0, 13484.12353197039, 13902.304884755924, 13786.241756703477, 13999.51001714935, 14251.64370890736, 14276.42894284217, 14429.7835532465, 13899.235542045284, 14308.284585770461, 14415.927920360331, 14432.85567144357, 14501.709965800836, 13155.473781048651, 13619.18284902909, 14146.0, 14172.220527870653, 14642.633934151732, 11215.327080375204, 11386.772264554496, 11806.291622502677, 11840.111991600837, 12046.397680116135, 11418.371989540323, 11687.590934317599, 11992.580259690869, 12158.209716368408, 12386.0], "value": 8118.770550457796, "unit": "score"}], "name": "dromaeo_css", "value": 7692.339737045854, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 110.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 120.0, 156.0, 121.0, 123.0, 123.0, 116.0, 150.0, 119.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 75.0, 74.0, 76.0, 74.0, 98.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 127.0, 81.0, 81.0, 81.0, 98.0, 81.0, 81.0, 111.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 98.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 52.0, 50.0, 49.0, 51.0, 50.0, 51.0, 49.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 61.0, 57.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 82.0, 73.0, 80.0, 74.0, 81.0, 74.0, 73.0, 73.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 121.0, 127.0, 121.0, 115.0, 117.0, 123.0, 158.0, 128.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 150.0, 153.0, 154.0, 154.0, 154.0, 152.0, 154.0, 153.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 63.0, 62.0, 64.0, 65.0, 62.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1455.8, "alertThreshold": 2.0}]} 11:17:19 INFO - Return code: 0 11:17:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:20 INFO - # TBPL SUCCESS # 11:17:20 INFO - Running post-action listener: _resource_record_post_action 11:17:20 INFO - [mozharness: 2016-10-04 18:17:20.053814Z] Finished run-tests step (success) 11:17:20 INFO - Running post-run listener: _resource_record_post_run 11:17:20 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358838272; Read time: 8; Write time: 215476 11:17:20 INFO - TinderboxPrint: CPU usage
12.9% 11:17:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:17:20 INFO - TinderboxPrint: I/O write bytes / time
358,838,272 / 215,476 11:17:20 INFO - TinderboxPrint: CPU idle
8,260.1 (87.0%) 11:17:20 INFO - TinderboxPrint: CPU user
1,187.0 (12.5%) 11:17:20 INFO - TinderboxPrint: Swap in / out
0 / 0 11:17:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107380736; Read time: 0; Write time: 68752 11:17:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 251006976; Read time: 0; Write time: 146720 11:17:20 INFO - Running post-run listener: _upload_blobber_files 11:17:20 INFO - Blob upload gear active. 11:17:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:20 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 11:17:20 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'] 11:17:20 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 11:17:21 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:21 INFO - (blobuploader) - INFO - Done attempting. 11:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:25 INFO - (blobuploader) - INFO - Done attempting. 11:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:17:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:26 INFO - (blobuploader) - INFO - Done attempting. 11:17:26 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:26 INFO - Return code: 0 11:17:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10cba069e6473405924950b9f9bd24fc30efe7cc47c8e2e3ceaa4399c530995e73cef51dfe450c4cb0f1e2bbc30cae1f1704cb59878e7353127f93151e6db305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f5584ad505cf3cc7b14261ed626a7229f0272558f9cf63c78d39e0fefcfc15cb3f792ace123a0cfbad93be984ee4f84b62f8c17479baa22cec6fbdde44ab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/099cf10ae90366268aab96c4d328412d782223f8d5089ca14a66f8b1ac8a710f743c0a7dffb5e495b25fd05729c5fdd1be74b3f956deb2fe677f893b8af243b1"} 11:17:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:26 INFO - Contents: 11:17:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10cba069e6473405924950b9f9bd24fc30efe7cc47c8e2e3ceaa4399c530995e73cef51dfe450c4cb0f1e2bbc30cae1f1704cb59878e7353127f93151e6db305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f5584ad505cf3cc7b14261ed626a7229f0272558f9cf63c78d39e0fefcfc15cb3f792ace123a0cfbad93be984ee4f84b62f8c17479baa22cec6fbdde44ab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/099cf10ae90366268aab96c4d328412d782223f8d5089ca14a66f8b1ac8a710f743c0a7dffb5e495b25fd05729c5fdd1be74b3f956deb2fe677f893b8af243b1"} 11:17:26 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:26 INFO - Copying logs to upload dir... 11:17:26 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.716884 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-04 11:17:25.654427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 11:17:25.662100) ========= 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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 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/10cba069e6473405924950b9f9bd24fc30efe7cc47c8e2e3ceaa4399c530995e73cef51dfe450c4cb0f1e2bbc30cae1f1704cb59878e7353127f93151e6db305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f5584ad505cf3cc7b14261ed626a7229f0272558f9cf63c78d39e0fefcfc15cb3f792ace123a0cfbad93be984ee4f84b62f8c17479baa22cec6fbdde44ab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/099cf10ae90366268aab96c4d328412d782223f8d5089ca14a66f8b1ac8a710f743c0a7dffb5e495b25fd05729c5fdd1be74b3f956deb2fe677f893b8af243b1"} build_url:https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/ZKhji_1PR5WjJoJzZYaHag/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/10cba069e6473405924950b9f9bd24fc30efe7cc47c8e2e3ceaa4399c530995e73cef51dfe450c4cb0f1e2bbc30cae1f1704cb59878e7353127f93151e6db305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f5584ad505cf3cc7b14261ed626a7229f0272558f9cf63c78d39e0fefcfc15cb3f792ace123a0cfbad93be984ee4f84b62f8c17479baa22cec6fbdde44ab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/099cf10ae90366268aab96c4d328412d782223f8d5089ca14a66f8b1ac8a710f743c0a7dffb5e495b25fd05729c5fdd1be74b3f956deb2fe677f893b8af243b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 11:17:25.690648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:17:25.691000) ========= 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=6dbc10da6d83fee962c624be000001a8-1475603295.653604-1780623618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:17:25.769529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 11:17:25.769860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 11:17:25.770163) ========= ========= Total master_lag: 0.19 =========