builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1484152830.06 results: success (0) buildid: 20170111064205 builduid: 00e9cfec35df48ee8a3e5fd136458ae4 revision: 6e945963ef7b6b04b33ae6763cde3bde23949809 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.064333) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.064839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.065176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.080415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.080741) ========= 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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-11 08:40:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.7M=0s 2017-01-11 08:40:30 (64.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.208699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.209094) ========= 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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:30.259178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 08:40:30.259579) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e945963ef7b6b04b33ae6763cde3bde23949809 --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-beta --rev 6e945963ef7b6b04b33ae6763cde3bde23949809 --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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-11 08:40:30,889 truncating revision to first 12 chars 2017-01-11 08:40:30,889 Setting DEBUG logging. 2017-01-11 08:40:30,889 attempt 1/10 2017-01-11 08:40:30,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e945963ef7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 08:40:31,463 unpacking tar archive at: mozilla-beta-6e945963ef7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914189 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 08:40:31.451216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:31.451629) ========= script_repo_revision: 6e945963ef7b6b04b33ae6763cde3bde23949809 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:31.452125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:31.452446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:40:31.463493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-11 08:40:31.463808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:32 INFO - MultiFileLogger online at 20170111 08:40:32 in /builds/slave/test 08:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:32 INFO - {'append_to_log': False, 08:40:32 INFO - 'base_work_dir': '/builds/slave/test', 08:40:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:32 INFO - 'branch': 'Mozilla-Beta', 08:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:32 INFO - 'config_files': ('talos/linux_config.py',), 08:40:32 INFO - 'default_actions': ('clobber', 08:40:32 INFO - 'read-buildbot-config', 08:40:32 INFO - 'download-and-extract', 08:40:32 INFO - 'populate-webroot', 08:40:32 INFO - 'create-virtualenv', 08:40:32 INFO - 'install', 08:40:32 INFO - 'run-tests'), 08:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:32 INFO - 'download_minidump_stackwalk': True, 08:40:32 INFO - 'download_symbols': 'ondemand', 08:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:32 INFO - 'installer_path': 'installer.exe', 08:40:32 INFO - 'log_level': 'info', 08:40:32 INFO - 'log_name': 'talos', 08:40:32 INFO - 'log_to_console': True, 08:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:32 INFO - 'opt_config_files': (), 08:40:32 INFO - 'pip_index': False, 08:40:32 INFO - 'sps_profile': False, 08:40:32 INFO - 'sps_profile_interval': 0, 08:40:32 INFO - 'suite': 'dromaeojs', 08:40:32 INFO - 'system_bits': '32', 08:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:32 INFO - 'title': 'talos-linux64-ix-010', 08:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:32 INFO - 'use_talos_json': True, 08:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:32 INFO - 'work_dir': 'build'} 08:40:32 INFO - [mozharness: 2017-01-11 16:40:32.189634Z] Running clobber step. 08:40:32 INFO - Running pre-action listener: _resource_record_pre_action 08:40:32 INFO - Running main action method: clobber 08:40:32 INFO - rmtree: /builds/slave/test/build 08:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:32 INFO - Running post-action listener: _resource_record_post_action 08:40:32 INFO - [mozharness: 2017-01-11 16:40:32.655657Z] Finished clobber step (success) 08:40:32 INFO - [mozharness: 2017-01-11 16:40:32.655758Z] Running read-buildbot-config step. 08:40:32 INFO - Running pre-action listener: _resource_record_pre_action 08:40:32 INFO - Running main action method: read_buildbot_config 08:40:32 INFO - Using buildbot properties: 08:40:32 INFO - { 08:40:32 INFO - "project": "", 08:40:32 INFO - "product": "firefox", 08:40:32 INFO - "script_repo_revision": "production", 08:40:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:40:32 INFO - "repository": "", 08:40:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:40:32 INFO - "buildid": "20170111064205", 08:40:32 INFO - "pgo_build": "True", 08:40:32 INFO - "basedir": "/builds/slave/test", 08:40:32 INFO - "buildnumber": 54, 08:40:32 INFO - "slavename": "talos-linux64-ix-010", 08:40:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:40:32 INFO - "platform": "ubuntu64_hw", 08:40:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:40:32 INFO - "branch": "mozilla-beta", 08:40:32 INFO - "repo_path": "releases/mozilla-beta", 08:40:32 INFO - "revision": "6e945963ef7b6b04b33ae6763cde3bde23949809", 08:40:32 INFO - "stage_platform": "linux64-pgo", 08:40:32 INFO - "builduid": "00e9cfec35df48ee8a3e5fd136458ae4", 08:40:32 INFO - "slavebuilddir": "test" 08:40:32 INFO - } 08:40:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 08:40:32 INFO - Running post-action listener: _resource_record_post_action 08:40:32 INFO - [mozharness: 2017-01-11 16:40:32.658204Z] Finished read-buildbot-config step (success) 08:40:32 INFO - [mozharness: 2017-01-11 16:40:32.658295Z] Running download-and-extract step. 08:40:32 INFO - Running pre-action listener: _resource_record_pre_action 08:40:32 INFO - Running main action method: download_and_extract 08:40:32 INFO - mkdir: /builds/slave/test/build/tests 08:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:32 INFO - trying https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:40:32 INFO - Downloading https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:40:40 INFO - Downloaded 1327 bytes. 08:40:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:40:40 INFO - Using the following test package requirements: 08:40:40 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 08:40:40 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:40 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 08:40:40 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'jsshell-linux-x86_64.zip'], 08:40:40 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:40 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 08:40:40 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 08:40:40 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 08:40:40 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:40 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:40:40 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:40 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 08:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 08:40:40 INFO - Expected file size: 21970937 08:40:45 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:40:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 08:40:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:45 INFO - Fetch https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 08:40:45 INFO - Expected file size: 21970937 08:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 08:40:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:50 INFO - Fetch https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 08:40:50 INFO - Expected file size: 14414089 08:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:51 INFO - trying https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:40:51 INFO - Downloading https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:40:52 INFO - Downloaded 56995043 bytes. 08:40:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:40:52 INFO - mkdir: /builds/slave/test/properties 08:40:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:52 INFO - Contents: 08:40:52 INFO - build_url:https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:40:53 INFO - Running post-action listener: _resource_record_post_action 08:40:53 INFO - Running post-action listener: set_extra_try_arguments 08:40:53 INFO - [mozharness: 2017-01-11 16:40:53.008617Z] Finished download-and-extract step (success) 08:40:53 INFO - [mozharness: 2017-01-11 16:40:53.008845Z] Running populate-webroot step. 08:40:53 INFO - Running pre-action listener: _resource_record_pre_action 08:40:53 INFO - Running main action method: populate_webroot 08:40:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:53 INFO - '--tppagecycles', 08:40:53 INFO - '7'], 08:40:53 INFO - 'tests': ['tsvgm']}}, 08:40:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['damp', 'tps']}, 08:40:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'tests': ['damp', 'tps']}, 08:40:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['dromaeo_dom']}, 08:40:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['basic_compositor_video']}, 08:40:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['a11yr', 08:40:53 INFO - 'ts_paint', 08:40:53 INFO - 'tpaint', 08:40:53 INFO - 'sessionrestore', 08:40:53 INFO - 'sessionrestore_no_auto_restore', 08:40:53 INFO - 'tabpaint']}, 08:40:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['tsvgx', 08:40:53 INFO - 'tsvgr_opacity', 08:40:53 INFO - 'tart', 08:40:53 INFO - 'tscrollx', 08:40:53 INFO - 'cart']}, 08:40:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:53 INFO - 'tsvgr_opacity', 08:40:53 INFO - 'tart', 08:40:53 INFO - 'tscrollx', 08:40:53 INFO - 'cart']}, 08:40:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'talos_options': ['--disable-e10s'], 08:40:53 INFO - 'tests': ['tp5o']}, 08:40:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'tests': ['tp5o']}, 08:40:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'talos_options': ['--disable-e10s', 08:40:53 INFO - '--xperf_path', 08:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:53 INFO - 'tests': ['tp5n']}, 08:40:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:53 INFO - 'talos_options': ['--xperf_path', 08:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:53 INFO - 'tests': ['tp5n']}}, 08:40:53 INFO - 'talos.zip': {'path': '', 08:40:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:53 INFO - Running post-action listener: _resource_record_post_action 08:40:53 INFO - [mozharness: 2017-01-11 16:40:53.028754Z] Finished populate-webroot step (success) 08:40:53 INFO - [mozharness: 2017-01-11 16:40:53.028848Z] Running create-virtualenv step. 08:40:53 INFO - Running pre-action listener: _resource_record_pre_action 08:40:53 INFO - Running main action method: create_virtualenv 08:40:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:53 INFO - Using real prefix '/usr' 08:40:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:55 INFO - Installing pip.................done. 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:55 INFO - Using env: {'DISPLAY': ':0', 08:40:55 INFO - 'HOME': '/home/cltbld', 08:40:55 INFO - 'LANG': 'en_US.UTF-8', 08:40:55 INFO - 'LANGUAGE': 'en_US:en', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MAIL': '/var/mail/cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SHLVL': '1', 08:40:55 INFO - 'TERM': 'linux', 08:40:55 INFO - 'TMOUT': '86400', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - '_': '/tools/buildbot/bin/python'} 08:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:55 INFO - Using env: {'DISPLAY': ':0', 08:40:55 INFO - 'HOME': '/home/cltbld', 08:40:55 INFO - 'LANG': 'en_US.UTF-8', 08:40:55 INFO - 'LANGUAGE': 'en_US:en', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MAIL': '/var/mail/cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SHLVL': '1', 08:40:55 INFO - 'TERM': 'linux', 08:40:55 INFO - 'TMOUT': '86400', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - '_': '/tools/buildbot/bin/python'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Downloading/unpacking psutil>=3.1.1 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:58 INFO - Installing collected packages: psutil 08:40:58 INFO - Running setup.py install for psutil 08:40:58 INFO - building 'psutil._psutil_linux' extension 08:40:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:40:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:40:58 INFO - building 'psutil._psutil_posix' extension 08:40:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:40:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:58 INFO - Successfully installed psutil 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:40:58 INFO - Using env: {'DISPLAY': ':0', 08:40:58 INFO - 'HOME': '/home/cltbld', 08:40:58 INFO - 'LANG': 'en_US.UTF-8', 08:40:58 INFO - 'LANGUAGE': 'en_US:en', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MAIL': '/var/mail/cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SHLVL': '1', 08:40:58 INFO - 'TERM': 'linux', 08:40:58 INFO - 'TMOUT': '86400', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - '_': '/tools/buildbot/bin/python'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:01 INFO - Installing collected packages: mozsystemmonitor 08:41:01 INFO - Running setup.py install for mozsystemmonitor 08:41:01 INFO - Successfully installed mozsystemmonitor 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:01 INFO - Using env: {'DISPLAY': ':0', 08:41:01 INFO - 'HOME': '/home/cltbld', 08:41:01 INFO - 'LANG': 'en_US.UTF-8', 08:41:01 INFO - 'LANGUAGE': 'en_US:en', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MAIL': '/var/mail/cltbld', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SHLVL': '1', 08:41:01 INFO - 'TERM': 'linux', 08:41:01 INFO - 'TMOUT': '86400', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - '_': '/tools/buildbot/bin/python'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:03 INFO - warning: no files found matching '*.txt' 08:41:03 INFO - no previously-included directories found matching 'build' 08:41:03 INFO - no previously-included directories found matching 'dist' 08:41:03 INFO - no previously-included directories found matching '.git*' 08:41:03 INFO - Installing collected packages: jsonschema, functools32 08:41:03 INFO - Running setup.py install for functools32 08:41:03 INFO - warning: no files found matching '*.txt' 08:41:03 INFO - no previously-included directories found matching 'build' 08:41:03 INFO - no previously-included directories found matching 'dist' 08:41:03 INFO - no previously-included directories found matching '.git*' 08:41:03 INFO - Successfully installed jsonschema functools32 08:41:03 INFO - Cleaning up... 08:41:03 INFO - Return code: 0 08:41:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:03 INFO - Using env: {'DISPLAY': ':0', 08:41:03 INFO - 'HOME': '/home/cltbld', 08:41:03 INFO - 'LANG': 'en_US.UTF-8', 08:41:03 INFO - 'LANGUAGE': 'en_US:en', 08:41:03 INFO - 'LOGNAME': 'cltbld', 08:41:03 INFO - 'MAIL': '/var/mail/cltbld', 08:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:03 INFO - 'MOZ_NO_REMOTE': '1', 08:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:03 INFO - 'NO_EM_RESTART': '1', 08:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:03 INFO - 'PWD': '/builds/slave/test', 08:41:03 INFO - 'SHELL': '/bin/bash', 08:41:03 INFO - 'SHLVL': '1', 08:41:03 INFO - 'TERM': 'linux', 08:41:03 INFO - 'TMOUT': '86400', 08:41:03 INFO - 'USER': 'cltbld', 08:41:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:03 INFO - '_': '/tools/buildbot/bin/python'} 08:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:04 INFO - Cleaning up... 08:41:04 INFO - Return code: 0 08:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:04 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:04 INFO - Using env: {'DISPLAY': ':0', 08:41:04 INFO - 'HOME': '/home/cltbld', 08:41:04 INFO - 'LANG': 'en_US.UTF-8', 08:41:04 INFO - 'LANGUAGE': 'en_US:en', 08:41:04 INFO - 'LOGNAME': 'cltbld', 08:41:04 INFO - 'MAIL': '/var/mail/cltbld', 08:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:04 INFO - 'MOZ_NO_REMOTE': '1', 08:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:04 INFO - 'NO_EM_RESTART': '1', 08:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:04 INFO - 'PWD': '/builds/slave/test', 08:41:04 INFO - 'SHELL': '/bin/bash', 08:41:04 INFO - 'SHLVL': '1', 08:41:04 INFO - 'TERM': 'linux', 08:41:04 INFO - 'TMOUT': '86400', 08:41:04 INFO - 'USER': 'cltbld', 08:41:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:04 INFO - '_': '/tools/buildbot/bin/python'} 08:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:07 INFO - Downloading docopt-0.6.1.tar.gz 08:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:07 INFO - Running setup.py install for blobuploader 08:41:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:07 INFO - Running setup.py install for requests 08:41:07 INFO - Running setup.py install for docopt 08:41:07 INFO - Successfully installed blobuploader requests docopt 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:07 INFO - Using env: {'DISPLAY': ':0', 08:41:07 INFO - 'HOME': '/home/cltbld', 08:41:07 INFO - 'LANG': 'en_US.UTF-8', 08:41:07 INFO - 'LANGUAGE': 'en_US:en', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MAIL': '/var/mail/cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SHLVL': '1', 08:41:07 INFO - 'TERM': 'linux', 08:41:07 INFO - 'TMOUT': '86400', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - '_': '/tools/buildbot/bin/python'} 08:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:07 INFO - Running setup.py (path:/tmp/pip-MZWz5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:07 INFO - Running setup.py (path:/tmp/pip-gujBVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:08 INFO - Running setup.py (path:/tmp/pip-Sf6qkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:08 INFO - Running setup.py (path:/tmp/pip-tmdj7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:08 INFO - Running setup.py (path:/tmp/pip-d2CfdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:08 INFO - Running setup.py (path:/tmp/pip-ydzmjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:08 INFO - Running setup.py (path:/tmp/pip-s2VwIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:08 INFO - Running setup.py (path:/tmp/pip-NwRxwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:08 INFO - Running setup.py (path:/tmp/pip-55vo2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:08 INFO - Running setup.py (path:/tmp/pip-XWrTH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:08 INFO - Running setup.py (path:/tmp/pip-x2ORs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:08 INFO - Running setup.py (path:/tmp/pip-eEqV89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:08 INFO - Running setup.py (path:/tmp/pip-wjiOBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:08 INFO - Running setup.py (path:/tmp/pip-VlHtmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 INFO - Running setup.py (path:/tmp/pip-BXAf1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:08 INFO - Running setup.py (path:/tmp/pip-8JUqiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:09 INFO - Running setup.py (path:/tmp/pip-YgAweP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:09 INFO - Running setup.py install for manifestparser 08:41:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozcrash 08:41:09 INFO - Running setup.py install for mozdebug 08:41:09 INFO - Running setup.py install for mozdevice 08:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozfile 08:41:09 INFO - Running setup.py install for mozhttpd 08:41:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozinfo 08:41:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozInstall 08:41:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozleak 08:41:10 INFO - Running setup.py install for mozlog 08:41:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for moznetwork 08:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozprocess 08:41:10 INFO - Running setup.py install for mozprofile 08:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozrunner 08:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozscreenshot 08:41:10 INFO - Running setup.py install for moztest 08:41:10 INFO - Running setup.py install for mozversion 08:41:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:10 INFO - Cleaning up... 08:41:10 INFO - Return code: 0 08:41:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:10 INFO - Using env: {'DISPLAY': ':0', 08:41:10 INFO - 'HOME': '/home/cltbld', 08:41:10 INFO - 'LANG': 'en_US.UTF-8', 08:41:10 INFO - 'LANGUAGE': 'en_US:en', 08:41:10 INFO - 'LOGNAME': 'cltbld', 08:41:10 INFO - 'MAIL': '/var/mail/cltbld', 08:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:10 INFO - 'MOZ_NO_REMOTE': '1', 08:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:10 INFO - 'NO_EM_RESTART': '1', 08:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:10 INFO - 'PWD': '/builds/slave/test', 08:41:10 INFO - 'SHELL': '/bin/bash', 08:41:10 INFO - 'SHLVL': '1', 08:41:10 INFO - 'TERM': 'linux', 08:41:10 INFO - 'TMOUT': '86400', 08:41:10 INFO - 'USER': 'cltbld', 08:41:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:10 INFO - '_': '/tools/buildbot/bin/python'} 08:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:11 INFO - Running setup.py (path:/tmp/pip-slDJPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:11 INFO - Running setup.py (path:/tmp/pip-OS4CMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:11 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)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:11 INFO - Running setup.py (path:/tmp/pip-mE_M0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:11 INFO - Running setup.py (path:/tmp/pip-SDxPMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:11 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)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:11 INFO - Running setup.py (path:/tmp/pip-Y08Fni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:11 INFO - Running setup.py (path:/tmp/pip-0em1Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:11 INFO - Running setup.py (path:/tmp/pip-fZ4ICs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:11 INFO - Running setup.py (path:/tmp/pip-R4KTCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:11 INFO - Running setup.py (path:/tmp/pip-6dyDrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:11 INFO - Running setup.py (path:/tmp/pip-PMvL3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Running setup.py (path:/tmp/pip-8SpxpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:11 INFO - Running setup.py (path:/tmp/pip-6Wnw0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:12 INFO - Running setup.py (path:/tmp/pip-umnsQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:12 INFO - Running setup.py (path:/tmp/pip-XZMkpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:12 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)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:12 INFO - Running setup.py (path:/tmp/pip-s4rSJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:12 INFO - Running setup.py (path:/tmp/pip-_O5Cil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:12 INFO - Running setup.py (path:/tmp/pip-6LDpOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:12 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)) 08:41:12 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)) 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:12 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)) 08:41:12 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)) 08:41:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - Downloading blessings-1.6.tar.gz 08:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:15 INFO - Installing collected packages: blessings 08:41:15 INFO - Running setup.py install for blessings 08:41:15 INFO - Successfully installed blessings 08:41:15 INFO - Cleaning up... 08:41:15 INFO - Return code: 0 08:41:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:15 INFO - Reading from file tmpfile_stdout 08:41:15 INFO - Current package versions: 08:41:15 INFO - argparse == 1.2.1 08:41:15 INFO - blessings == 1.6 08:41:15 INFO - blobuploader == 1.2.4 08:41:15 INFO - docopt == 0.6.1 08:41:15 INFO - functools32 == 3.2.3-2 08:41:15 INFO - jsonschema == 2.5.1 08:41:15 INFO - manifestparser == 1.1 08:41:15 INFO - mozInstall == 1.12 08:41:15 INFO - mozcrash == 0.17 08:41:15 INFO - mozdebug == 0.1 08:41:15 INFO - mozdevice == 0.48 08:41:15 INFO - mozfile == 1.2 08:41:15 INFO - mozhttpd == 0.7 08:41:15 INFO - mozinfo == 0.9 08:41:15 INFO - mozleak == 0.1 08:41:15 INFO - mozlog == 3.4 08:41:15 INFO - moznetwork == 0.27 08:41:15 INFO - mozprocess == 0.23 08:41:15 INFO - mozprofile == 0.28 08:41:15 INFO - mozrunner == 6.12 08:41:15 INFO - mozscreenshot == 0.1 08:41:15 INFO - mozsystemmonitor == 0.3 08:41:15 INFO - moztest == 0.7 08:41:15 INFO - mozversion == 1.4 08:41:15 INFO - psutil == 3.1.1 08:41:15 INFO - requests == 1.2.3 08:41:15 INFO - wsgiref == 0.1.2 08:41:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 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 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:15 INFO - Using env: {'DISPLAY': ':0', 08:41:15 INFO - 'HOME': '/home/cltbld', 08:41:15 INFO - 'LANG': 'en_US.UTF-8', 08:41:15 INFO - 'LANGUAGE': 'en_US:en', 08:41:15 INFO - 'LOGNAME': 'cltbld', 08:41:15 INFO - 'MAIL': '/var/mail/cltbld', 08:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:15 INFO - 'MOZ_NO_REMOTE': '1', 08:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:15 INFO - 'NO_EM_RESTART': '1', 08:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:15 INFO - 'PWD': '/builds/slave/test', 08:41:15 INFO - 'SHELL': '/bin/bash', 08:41:15 INFO - 'SHLVL': '1', 08:41:15 INFO - 'TERM': 'linux', 08:41:15 INFO - 'TMOUT': '86400', 08:41:15 INFO - 'USER': 'cltbld', 08:41:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:15 INFO - '_': '/tools/buildbot/bin/python'} 08:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:16 INFO - Cleaning up... 08:41:16 INFO - Return code: 0 08:41:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4731964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41: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'] in /builds/slave/test/build 08:41: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 08:41:16 INFO - Using env: {'DISPLAY': ':0', 08:41:16 INFO - 'HOME': '/home/cltbld', 08:41:16 INFO - 'LANG': 'en_US.UTF-8', 08:41:16 INFO - 'LANGUAGE': 'en_US:en', 08:41:16 INFO - 'LOGNAME': 'cltbld', 08:41:16 INFO - 'MAIL': '/var/mail/cltbld', 08:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:16 INFO - 'MOZ_NO_REMOTE': '1', 08:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:16 INFO - 'NO_EM_RESTART': '1', 08:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:16 INFO - 'PWD': '/builds/slave/test', 08:41:16 INFO - 'SHELL': '/bin/bash', 08:41:16 INFO - 'SHLVL': '1', 08:41:16 INFO - 'TERM': 'linux', 08:41:16 INFO - 'TMOUT': '86400', 08:41:16 INFO - 'USER': 'cltbld', 08:41:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:16 INFO - '_': '/tools/buildbot/bin/python'} 08:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:16 INFO - Cleaning up... 08:41:16 INFO - Return code: 0 08:41:16 INFO - Running post-action listener: _resource_record_post_action 08:41:16 INFO - Running post-action listener: _start_resource_monitoring 08:41:16 INFO - Starting resource monitoring. 08:41:16 INFO - [mozharness: 2017-01-11 16:41:16.332872Z] Finished create-virtualenv step (success) 08:41:16 INFO - [mozharness: 2017-01-11 16:41:16.333370Z] Running install step. 08:41:16 INFO - Running pre-action listener: _resource_record_pre_action 08:41:16 INFO - Running main action method: install 08:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:16 INFO - Reading from file tmpfile_stdout 08:41:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:16 INFO - Reading from file tmpfile_stdout 08:41:16 INFO - Output received: 08:41:16 INFO - Usage: mozinstall [options] installer 08:41:16 INFO - Options: 08:41:16 INFO - -h, --help show this help message and exit 08:41:16 INFO - -d DEST, --destination=DEST 08:41:16 INFO - Directory to install application into. [default: 08:41:16 INFO - "/builds/slave/test"] 08:41:16 INFO - --app=APP Application being installed. [default: firefox] 08:41:16 INFO - mkdir: /builds/slave/test/build/application 08:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:30 INFO - Reading from file tmpfile_stdout 08:41:30 INFO - Output received: 08:41:30 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:30 INFO - Running post-action listener: _resource_record_post_action 08:41:30 INFO - [mozharness: 2017-01-11 16:41:30.835315Z] Finished install step (success) 08:41:30 INFO - [mozharness: 2017-01-11 16:41:30.835568Z] Running run-tests step. 08:41:30 INFO - Running pre-action listener: _resource_record_pre_action 08:41:30 INFO - Running main action method: run_tests 08:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:30 INFO - Python 2.7.3 08:41:30 INFO - Return code: 0 08:41:30 INFO - grabbing minidump binary from tooltool 08:41: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')]} 08:41:30 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 0x2b04f60>, '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 0x2b05d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b061d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:41:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:30 INFO - Return code: 0 08:41:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:30 INFO - Using env: {'DISPLAY': ':0', 08:41:30 INFO - 'HOME': '/home/cltbld', 08:41:30 INFO - 'LANG': 'en_US.UTF-8', 08:41:30 INFO - 'LANGUAGE': 'en_US:en', 08:41:30 INFO - 'LOGNAME': 'cltbld', 08:41:30 INFO - 'MAIL': '/var/mail/cltbld', 08:41:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:30 INFO - 'MOZ_NO_REMOTE': '1', 08:41:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:30 INFO - 'NO_EM_RESTART': '1', 08:41:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:30 INFO - 'PWD': '/builds/slave/test', 08:41:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:30 INFO - 'SHELL': '/bin/bash', 08:41:30 INFO - 'SHLVL': '1', 08:41:30 INFO - 'TERM': 'linux', 08:41:30 INFO - 'TMOUT': '86400', 08:41:30 INFO - 'USER': 'cltbld', 08:41:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223', 08:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:30 INFO - '_': '/tools/buildbot/bin/python'} 08:41:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:31 INFO - mozversion application_buildid: 20170111064205 08:41:31 INFO - mozversion application_changeset: 6e945963ef7b6b04b33ae6763cde3bde23949809 08:41:31 INFO - mozversion application_display_name: Firefox 08:41:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:31 INFO - mozversion application_name: Firefox 08:41:31 INFO - mozversion application_remotingname: firefox 08:41:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:31 INFO - mozversion application_vendor: Mozilla 08:41:31 INFO - mozversion application_version: 51.0 08:41:31 INFO - mozversion platform_buildid: 20170111064205 08:41:31 INFO - mozversion platform_changeset: 6e945963ef7b6b04b33ae6763cde3bde23949809 08:41:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:31 INFO - mozversion platform_version: 51.0 08:41:31 INFO - using testdate: 1484152891 08:41:31 INFO - actual date: 1484152891 08:41:31 INFO - starting webserver on 'localhost:60072' 08:41:31 INFO - SUITE-START | Running 2 tests 08:41:31 INFO - TEST-START | dromaeo_css 08:41:31 INFO - operating with platform_type : linux_ 08:41:31 INFO - Initialising browser for dromaeo_css test... 08:41:31 INFO - TEST-INFO | started process 17660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxdZO6/profile http://localhost:60072/getInfo.html) 08:41:35 INFO - PROCESS | 17660 | __metrics Screen width/height:1600/1200 08:41:35 INFO - PROCESS | 17660 | colorDepth:24 08:41:35 INFO - PROCESS | 17660 | Browser inner width/height: 1024/697 08:41:35 INFO - PROCESS | 17660 | __metrics 08:41:36 INFO - PROCESS | 17660 | 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" 08:41:36 INFO - PROCESS | 17660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:37 INFO - PROCESS | 17660 | console.error: PushService: 08:41:37 INFO - PROCESS | 17660 | stateChangeProcessEnqueue: Error transitioning state 08:41:37 INFO - PROCESS | 17660 | UnknownError 08:41:37 INFO - TEST-INFO | 17660: exit 0 08:41:37 INFO - Browser initialized. 08:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:37 INFO - TEST-INFO | started process 17753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxdZO6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:49 INFO - PROCESS | 17753 | RSS: Main: 143474688 08:41:49 INFO - PROCESS | 17753 | 08:42:40 INFO - PROCESS | 17753 | 1484152960278 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:44:49 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60072/tests/dromaeo/cssquery-ext.html) 08:44:50 INFO - PROCESS | 17753 | RSS: Main: 238673920 08:44:50 INFO - PROCESS | 17753 | 08:47:52 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-ext.html (next: http://localhost:60072/tests/dromaeo/cssquery-jquery.html) 08:47:53 INFO - PROCESS | 17753 | RSS: Main: 232386560 08:47:53 INFO - PROCESS | 17753 | 08:50:55 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60072/tests/dromaeo/cssquery-mootools.html) 08:50:55 INFO - PROCESS | 17753 | RSS: Main: 208482304 08:50:55 INFO - PROCESS | 17753 | 08:53:57 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60072/tests/dromaeo/cssquery-prototype.html) 08:53:58 INFO - PROCESS | 17753 | RSS: Main: 202821632 08:53:58 INFO - PROCESS | 17753 | 08:57:00 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60072/tests/dromaeo/cssquery-yui.html) 08:57:01 INFO - PROCESS | 17753 | RSS: Main: 177504256 08:57:01 INFO - PROCESS | 17753 | 09:00:03 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-yui.html (next: http://localhost:60072/tests/dromaeo/cssquery-dojo.html) 09:00:04 INFO - PROCESS | 17753 | RSS: Main: 259239936 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | __start_tp_report 09:00:04 INFO - PROCESS | 17753 | _x_x_mozilla_page_load 09:00:04 INFO - PROCESS | 17753 | _x_x_mozilla_page_load_details 09:00:04 INFO - PROCESS | 17753 | |i|pagename|runs| 09:00:04 INFO - PROCESS | 17753 | |0;dojo.html;3042.969570304297;3081.9383612327747;3095.117891400951;3120.3759248150377;3121.3601211751593;5369.140937450009;5432.239486471892;5453.863653408666;5454.10007348788;5482.068048431766;5429.348478182614;5429.809956651518;5456.454354564542;5463.180522921563;5479.917801232975;4956.553910148095;4991.775370108336;5017.122003649365;5076.263941728447;5082.898342033157;4892.510748925097;5019.14674505335;5075.06111369396;5075.264086707425;5076.746162691869;4885.511448855122;4923.310736496894;4993.725345106018;4998.375203099613;5019.222020586815;5033.949660503403;5061.772220250097;5071.898562028776;5144.768485418165;5175.120229560984;5007.974960125176;5021.422536408323;5098.59211263098;5107.259447380146;5113.667611605271;5106.540411362958;5213.061648903196;5263;5289.788408463657;5316.707581083039;5742.368339482654;5778.0466223073145;5783.797567085174;5847.502962248214;5851.180834683148;5892.499137573312;5893.734781934823;5896.292444906639;5905.940940590582;5910.202122713422;5264.394594621591;5321.148616221425;5354.9196762048605;5411.188321751769;5445.50990410857;6015.819525414245;6021.157038014681;6039.426254505903;6039.486643635252;6040.728167232485;5784.566157538202;5784.942150578525;5785.681787501728;5788.247527821356;5789.305283366023;5527.336719593594;5578.9163162552595;5707.800226992035;5753.971230143822;5754.971225143848;5767.971160144172;5769.769209231584;5771.653700777967;5775.133729940542;5793.8841223175305;5748.511376533042;5799.3620701722775;5804.709764511757;5805.36141024487;5830.7084645767545;4371.213181627274;4411.823527058882;4450.666200035011;4485.955140448554;4513.232750432434;3978.6817054635558;4030.496187976503;4050.736702114353;4051.0682543015273;4063.045184381668;5574.498295153456;5578.748956296977;5580.441955804387;5581.609287349927;5582.8325150245555;5621.7189140542805;5674;5688.11834165705;5874.559408044413;5877.294724633071;5443;5486.780528778804;5507.366652834895;5522.364928033247;5537.889242215133;5027.1956486962645;5036.219385995177;5039.294498770175;5055.418626857885;5060.873478163076;5752.252207213036;5756.94243057564;5940.405959404025;5942.821715348547;5956.612820166675;5744.281964754406;5765.077587585966;5772.018756811268;5815.738291776965;5820.359760426434;5976.9103463448955;5982.132590774227;5984.611000284967;5986.970065149646;5992.940070599413;5488.341399032141;5728.4271572844045;5728.455796699307;5740.483356497768;5746.482816546531;5609.411011843697;5743.9138412923;5774.653520788766;5788.27646544182;5879.941200587939;5715.685637289989;5717.742701578356;5718.628289161191;5719.599628025998;5722.713864306685;5609.887802244014;5708.54331653475;5717.799877004451;5722.62802917809;5728.054870946247;5494.2582751328055;5533.861653458695;5607.074832652566;5626.015447296625;5676.68778217202;5807.041838096667;5816.70916454184;5818.94181058184;5821.446962538552;5822.388649191943;5417.51242388187;5677.205191273142;5678.545716342765;5685.317761868602;5693.686847223443 09:00:04 INFO - PROCESS | 17753 | |1;ext.html;591.2609238451935;610.1397030187435;628.2680677011283;638.250056183984;652.2922628947591;33522.83238583807;34044.48933266;44153.7792311038;45173.09653806922;45215.77392113043;43513;46963.53036469643;47387.52612473874;47394.28908566366;47523.52476475234;8155.918440815575;9131.771705707377;9300.11648893354;9300.302477314195;9302;8308.70919517817;10877.456127193609;11113.110951123932;11113.277636953571;11569.884301157006;11269.66191014271;11350.09199264057;11356.829647555292;11357.261777984404;11361;10664.840027399596;10721.678349649523;10727.463626818628;10729.517171727291;10734.194935379839;11014;11106.666799996014;11106.777864442665;11109.111271098292;11111.222214444992;44047.11905761899;44185.33721994173;44271;44422.55577444217;44429.555704442864;3558.19940513385;3643.03459583208;3691.593924668284;3878.5151856017997;4017.738846974937;34334.656653433645;34456.310873782386;34485.65514344849;34634.48048279278;34830.82584587086;4656.813727450898;4705.364775755298;4731.621470282369;4742.264948932921;4747.596454301389;337072.99999999756;337765;339292;339522;339567;60145.69927150336;60378;60458.697706511186;60498;60523.092153617734;38894.80552597219;39475;39564.60435395667;41693.79153104215;41989.74030779082;17549.473515794547;17722.379716709853;17747.73378399325;17759.112044397727;17770.733438998166;12038.33789141588;12258.08064395174;13170.736585268241;13493.865061349457;13606.795898061537;20250.89874550618;20263.189472421232;20420.183192672128;20421.89789051075;20425.591488170154;7402.888956665654;7597.924020759832;7632.580208088498;7644.426667999922;7698.34564062061;950.273041123541;1096.4188979840696;1106.9280496767685;1109.778044391125;1176.3823992404057;32105.357892842014;34603.307933841184;34867;36337;36621;1164.3654208456412;1175.9710253528162;1176.353005846781;1204.5543149034913;1227.5887577661583;16042.839571604369;16441;16505.6698866022;16716.916415417843;17013.14934253307;479104;489937;490093;491538;492124;61600;62237;62250.68874655688;62330.37669623336;62399;1334.252818421687;1342.3757952551914;1370.7806750919806;1455.4978532406303;1482.992585037068;30165.698343017168;33987;34053.48919766156;34234.31531369408;34645.307093858486;53287.20069198887;53667;53847.192292114865;53900;53902.460975389746;429626;432772;433928;434318;435088;45777;46627.57038081377;46846.29730553976;47173.29240061333;47241;49412.50587494079;50861.23708144307;50896;51263.743681281354;51355.22967155421;43135.784321078194;43184.78407607942;43557;43656.78171609122;45405.09189816119;42513;43095.13809723851;43546.12907741891;43651.34522982221;43782.34326485169;42194.156116876875;42901.356479652204;42908.570914291704;42924.14151716886;43156.352654710834;35837.46243806397;37860.81069594635;38174.80912595419;38382.23235535218;39083;28241.50314477835;28743.71256287494;28795.42409151847;28870.566941496316;28988.855055724587 09:00:04 INFO - PROCESS | 17753 | |2;jquery.html;405.61263992886796;410.3905700035445;424.3549804297468;434.5372178629758;445.4098319726363;19037.143328550213;19488.610227795452;20812.89593552034;20843.478913027182;20987.580248395025;18834.43496695098;19330.226790928347;19897.801021989777;20067.09698063587;20092.995350232504;5744.195812586241;6018.097285407202;6019.729112189962;6026.698665066751;6041.124037014631;5706.971465142689;5904.173415721781;5930.110483427477;5966.970165149168;5973.22348094747;6028.728707208186;6032.517398608101;6033.969830150843;6035.124906888498;6038.667873266969;5836.883262334751;5964.582479226456;6008.579399442041;6010.248718910092;6030.849228769294;5825.271841019872;5844.766209351621;5846.7076646167525;5850.97074514629;5854.560907931879;13802.240876751775;14139.434422623082;14164.85835141656;14369.353379097862;14473.493427729978;2449.2652204338806;2497.0261597976805;2524.0534799450206;2548.24826676131;2917.401932603811;10759.946200268949;10836.187285953585;11915.165938384316;14053.859461405358;15498.225088745517;1774.308019872251;1916.568772026297;1916.9424917252504;1918.856085793571;1931.690929451295;79475;83481;83601.58199209026;84730;85674.57162714208;11487.42562871853;11750;11860.22908510944;11931.642050738492;11974.820377694341;16933.322667093424;16945.237464314134;17024.48926532206;17050.317987280618;17052.573685657957;8331.708390206313;8354.58227088643;8396.370272229608;8514.616842242114;8524.445911015888;7808.41436892224;7905.407094467938;8028.638711258008;8111;8137;4501.48232953208;4506.414166158378;4982.327385802871;5083.754480152386;5199.376074870964;1947.6202140582734;1950.5806251655963;1966.852486063551;2014.6602509331424;2023.2311721546014;882.9072947340566;971.3152227679469;977.5747549815853;995.7261753017978;1023.8452064754458;19381.321653742052;20486.59026819455;20752.792472075085;20842.37472875816;20977.160913563286;942.1426501883391;953.4708236928433;978.0854900667756;982.4400091947664;1020.8774947006407;10739.946300268448;11290.378577840926;11319.151063670257;11326;11537.134714896416;486150;494151;498330.0834958238;498483;499907;74406.6279668609;75705;95803.52098239603;96750.51624741971;99988.50005749924;967.2793768642266;994.1202036198017;995.9542480395555;997.9201663866874;1007.3552926127285;17037.48887533376;17950;18050.638987220445;18404.63190736151;18606.81393186051;45538.31692524681;45636;45998;46220.07559848851;46311.536884630725;57467.712661436424;61450.692746535984;62502;63371;64497.67751161214;9000.819983600422;9317.301202409712;9343.626254949726;9384.57769400365;9476.85784713216;12280.570180043656;14302.642433939234;14446.783298250744;14588.85411145875;14596.489122880648;11932.940335298268;12122.636320910387;12204.87795122073;12310.138290319592;12459.501619935101;11884.039133542869;12265.448054837732;12293.631191064282;12437.378131093228;12610.558630448257;12000.819987700366;12141.150119491904;12212.816807748068;12349.93825030869;12507.061970352443;9080.591373388346;9129.863052054092;9158.95420522893;9250.583723732583;9970.601175952881;11972.221805582609;12208.45061972231;12353.62939111828;12392.070594705614;12404.131710780159 09:00:04 INFO - PROCESS | 17753 | |3;mootools.html;1404.8033275341452;1485.3835658201847;1582.5489735425392;1610.9275082621282;1776.1385727921947;8362.749117526477;9032.72901812946;9036;9045.050269721683;9046.321525885553;7580.431467639935;7850.136484986647;8470.322374210064;8754;8873.73378798637;2397.364698354933;2426.2842461473906;2428.4657375377387;2431.3435372449517;2435.9756402436014;2386.713594368678;2387;2423.9272821815284;2426.696662917135;2426.9271921842374;2356.3284463927785;2372.0156135203956;2372.727136379321;2381.4641705616273;2388.8327817052814;2313.1210140146723;2318.3508617587186;2319.0375993962484;2319.7912187903084;2369.206315884164;2323.4772176260376;2335.100986120339;2338.1232037985756;2340.180936672168;2342.0631747301045;8494.74515764528;8664;8667.523286219255;8669;8670.436421632574;5207.765650545734;5337.8131765388025;5343.866403339909;5346.358436987547;5350.250964864883;3235.3367559650214;3277.246233366315;3333.283344081034;3340.6993370596765;3341.097903566048;1113.2318700096907;1113.4377139544558;1118.429600903545;1141.8915203055778;1154.5035634677085;12195.329256890867;12211.45048472812;12223.14437989341;12235.571754988532;12252.14235003559;4396.252637051709;4428;4584.816607335736;4590.495045544987;4631.745254011062;10478.842817357745;10490.05589496949;10490.05589496949;10495;10500.47497625131;5296.655717378358;5309.070912590359;5315.335583052119;5350.839474815684;5351.03681337363;4103.569125241806;4187.769672668032;4244.830206791756;4726.03116361152;4861.465238823726;3749.1751814600743;3855;3919.6080391960577;3949.2101579684177;4037.7981100944835;1222.1872454817624;1223.3455101520822;1224.1430998301046;1242.658268976039;1242.7203879127305;726.3063774095726;839.261449924063;845.6490556419141;847.9364047696447;860.7934095816959;5628.127640215773;5639.548836093103;5683.886322273532;5727.742251598688;5767.625104368202;946.1342871272846;995.7361299255703;995.9502024898726;997.5631665930471;1010.2322235101229;3630;3664.193877346979;3775.8300876460626;3830.8467661293234;3946.940795888064;10717.678469645924;11122.443877806078;11127.221094523467;11135.888641113646;11189.384583847805;11007.394593297286;11016.339019658846;11023.17326200538;11041.668749937515;11090.944545277222;8010;8415.537145456936;8426.915730842737;8441.282490988335;8479.491230526188;5617.494425501724;5635.549156067586;5759.280089988752;5785.971070144622;5838.824835254779;9439.386439881386;9498.19265362452;9520.381175223589;9975.950120249352;10063.245256605931;10221.488925553544;10278;10441.63454279127;10474.52864621109;10483.37099774016;7346.632668366454;7521.586312752632;7541.43439242048;7544.207858175032;7548.773536793905;8180.222878826502;8222.095569487472;8226;8231.547264900488;8236.217559331853;7178.318059784312;7199.748008819666;7211.2428195038765;7339;7445.957565940665;7351.485396022227;7437.107547094383;7452.701891924479;7550.6786312394015;7679.808004799925;6989.510734248757;7089.893651595334;7090.680919358538;7100;7103.396211322096;4810.230363141881;4825.10735513931;4885.145099607484;4887.633427493023;5024.799008039638;4878.438979517401;4891.437484689306;4978.850634480971;4983.352164218773;5023.799048038038 09:00:04 INFO - PROCESS | 17753 | |4;prototype.html;325.83219641884426;335.1905149065008;337.2075622287624;342.67617101838755;351.9542459480267;5284.44513326101;5438.755256013479;5475.397706252309;5506.531944784693;5514.6139770216105;5316.574674026078;5418.4039755626945;5442.673439593627;5450.836474905759;5463.808766693167;4339.414179085815;4349.41282926804;4350.129974005195;4357.956420435795;4378.35811570661;4246.787660616972;4295.871123866289;4338.696291259613;4362.629176519999;4369.3227549729845;4331.588499092597;4331.65346772259;4340.587644173798;4349.41282926804;4350.825966961318;4313.892152696177;4336.8265269389185;4343.761093139876;4346.304591265382;4358.912821743547;3585.623509531488;3886.639676113366;3912.6674232690257;3913.8434462621462;3916.5887581803786;5303.840884773463;5316.840494785162;5318.574514038867;5346.4118946915805;5375.193720941851;4917.385326834145;4920.975395123037;4922.778474968635;4940.728259945701;4958;5526.861828454281;5717.914231286534;5750.7987220447085;5760.567957403169;5766.884662306772;4176.62410383064;4177.3316269396755;4180.393842892763;4181.6236538711355;4188.099558594917;5966.910496342558;5983.910241346383;6014.278286605635;6016.743721104585;6110.266767987825;4085.3463445849115;4202.8232095013445;4223.640990515779;4234.724742891703;4274.273373526508;4330.956690433119;4350.630196433339;4356.564343565618;4358.8038538265855;4366.279563871989;4874;4905.23968784839;4906.460289368167;4906.484819094015;4914.213725803854;5634.577406694432;5779.739911703983;5796.1595568642315;5827.475527202572;5877.676727779927;1358.8641135886332;1382.2743059893435;1385.217352196006;1386.6671998720235;1387.8959078069186;994.3685759542742;1017.1557607186018;1030.5980667539666;1043.6973277749519;1044.383813550009;5561.388247292794;5565.359983601857;5575.860603484864;5578.748956296977;5580.693061881636;5772.181762744722;5822;5840.715042690601;5852.941470585325;5878.823635290948;5399.406065332811;5523.392426833045;5550.250716153349;5560.527355174774;5637.605367624227;3133.7649676274373;3167.2081979505124;3173.7778355514893;3177.3645270945904;3179.4277030134335;5980.677048406743;6118.6137406411535;6128.785492507741;6187.319394866561;6194.690265486798;6017.849553761191;6037.456628903332;6075.5747097703625;6075.635461872213;6081.209442772411;6119.938800612026;6129.172561704202;6130.601510901777;6132.662703551258;6200.286966998853;5634.464725851038;5950.672713000653;5955.91066134017;5969.791057313147;6047.5464340173785;5898.613825751031;5903.822885313448;5914;5925.4370834770625;5930.881382372242;5860.824175274749;6149.7847575334645;6190.380961903774;6194.938050619617;6202.782902598387;4208.705390622627;4247.023184667482;4265.808038638331;4279.935800962926;4283.678724095643;6012.248468941382;6014.248218972629;6022.76533310679;6076.8784624308155;6090.177825993434;5680.665043714641;5722.599418040697;5732.455416735404;5821.621594596338;5845.678487683218;5801.216835727123;5817.76728930838;5823.679697616672;5827.737751801264;5830.416958304136;5678.74445649955;5736.569757268138;5773.422657734361;5796.072628379439;5836.795712150054;5809.970950145223;5821.1954294168945;5864;5865.477844526724;5875.294964604275;5713.085906254979;5717.799877004285;5719.599628025998;5735.827925162085;5772.797952071657 09:00:04 INFO - PROCESS | 17753 | |5;yui.html;719.2950908110049;770.9036370453694;785.4227143049858;798.7100832156068;869.6825658634592;15015.47445839396;15944.36222551098;16385.180740962966;16653;16725.330986760517;14517.346719397627;14632.268386580681;14680.412783488675;14691.485797997073;14716.484923027696;547.1218693996138;585.3122580967367;589.0957380421055;679.5243329669252;721.6211488968281;594.9048152295634;596.8000719758886;597.8505373656586;598.3209057719498;598.4464370457309;621.6953692690572;624.3725056318393;624.4286477872741;625.046803624474;625.2028663454109;620.6214209332304;621.6518749500294;622.3714048810689;623.155624129305;623.3174673732256;454.63856234293814;454.8089802283016;454.8976480291941;454.9909001819945;455.1170728786144;14754.188519631416;14760.040597361138;14760.630984225372;14767.704645907022;14798.63003424923;16240.512784616361;16292.592685182846;16342;16486.505404837873;16923.915380423143;12817.23096614206;12966.675833104247;13057.738845223043;13222.73554528904;13571.524996625169;3942.3889297158985;3962.286788378091;3972.9006774830573;4119.588041195886;4134.235166494208;88717.55641221753;88781.55609221978;90071.54964225202;90331;93169.53415232948;12157.635270941886;12390.194637348724;12415.93792031034;12991.025673074557;13616.727665446833;22661.433464163198;23781.167659131846;24605.5078898421;24622.507549848902;24763.5047299053;8734.86897696535;8775.341849361323;9244.630214791467;9322.347435679438;9624.422534647943;4808.2547205183255;4826.517348265145;4837.467878533358;4965.652404331734;5255.947440525622;3525.7003154731624;3620.601733809279;3646.033801042726;3651.744377893575;3654.14127679995;601.8465291350677;602.7860109661007;609.4210500024994;609.6738245038883;614.563659801537;635.5773410681845;642.7236288395941;652.6606164794281;663.0352836622702;681.0839420978775;8983.416077954913;9491.430514169171;9722.098114556318;9804.215662746963;9992.550335234931;644.6422235659161;650.2554575011585;655.5476721062452;667.1194023888518;693.7883945396602;4434.379186913835;4614.930776038362;4761.952380476151;4801.663883528189;4821.083994041121;100476;101393;128821.35589321994;132891;133071;60549;99350;100788.49605751924;101015.49492252491;105148;83087.16912830915;83655;83719.32733656636;89197;91555.54222228847;9901.455419951972;10349.223808214263;10468.63359782404;10482;10544;47854.760726196146;54921.45078549163;55314.89370212654;56925.430745692014;57524.42475575358;68734;77163.61418192873;77338;77846;83352.16647833445;13345.199288042748;13648.301811567197;13684.726305474034;13708.3831227593;13832.239226842621;14604.561863144123;14765.630859228606;15143.091414515164;15181.468648597245;16158.434454794025;13727.931360343135;14374.928125359307;14596.343164557833;14666.120032798066;14957.850421495647;13826.723465530431;14028.29858507091;14389.136651800925;14407.135571865721;14733.116013039253;13030.283334416697;13390.129641573267;13459.394327255493;13518.729625407634;13573.864261357656;11063.557457701601;11084.445777711244;11830.585929492427;12393.876061239273;12945.705429456979;10757.838632420677;10966.616168434066;11205.495752691311;11646.301221926711;12070.456829442872 09:00:04 INFO - PROCESS | 17753 | __end_tp_report 09:00:04 INFO - PROCESS | 17753 | __start_cc_report 09:00:04 INFO - PROCESS | 17753 | _x_x_mozilla_cycle_collect,886 09:00:04 INFO - PROCESS | 17753 | __end_cc_report 09:00:04 INFO - PROCESS | 17753 | __startTimestamp1484154004209__endTimestamp 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | ------- Summary: start ------- 09:00:04 INFO - PROCESS | 17753 | Number of tests: 6 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#0] dojo.html Cycles:165 Average:5406.26 Median:5609.41 stddev:602.06 (10.7%) stddev-sans-first:574.65 09:00:04 INFO - PROCESS | 17753 | Values: 3043.0 3081.9 3095.1 3120.4 3121.4 5369.1 5432.2 5453.9 5454.1 5482.1 5429.3 5429.8 5456.5 5463.2 5479.9 4956.6 4991.8 5017.1 5076.3 5082.9 4892.5 5019.1 5075.1 5075.3 5076.7 4885.5 4923.3 4993.7 4998.4 5019.2 5033.9 5061.8 5071.9 5144.8 5175.1 5008.0 5021.4 5098.6 5107.3 5113.7 5106.5 5213.1 5263.0 5289.8 5316.7 5742.4 5778.0 5783.8 5847.5 5851.2 5892.5 5893.7 5896.3 5905.9 5910.2 5264.4 5321.1 5354.9 5411.2 5445.5 6015.8 6021.2 6039.4 6039.5 6040.7 5784.6 5784.9 5785.7 5788.2 5789.3 5527.3 5578.9 5707.8 5754.0 5755.0 5768.0 5769.8 5771.7 5775.1 5793.9 5748.5 5799.4 5804.7 5805.4 5830.7 4371.2 4411.8 4450.7 4486.0 4513.2 3978.7 4030.5 4050.7 4051.1 4063.0 5574.5 5578.7 5580.4 5581.6 5582.8 5621.7 5674.0 5688.1 5874.6 5877.3 5443.0 5486.8 5507.4 5522.4 5537.9 5027.2 5036.2 5039.3 5055.4 5060.9 5752.3 5756.9 5940.4 5942.8 5956.6 5744.3 5765.1 5772.0 5815.7 5820.4 5976.9 5982.1 5984.6 5987.0 5992.9 5488.3 5728.4 5728.5 5740.5 5746.5 5609.4 5743.9 5774.7 5788.3 5879.9 5715.7 5717.7 5718.6 5719.6 5722.7 5609.9 5708.5 5717.8 5722.6 5728.1 5494.3 5533.9 5607.1 5626.0 5676.7 5807.0 5816.7 5818.9 5821.4 5822.4 5417.5 5677.2 5678.5 5685.3 5693.7 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#1] ext.html Cycles:180 Average:59604.43 Median:39519.80 stddev:111984.36 (283.4%) stddev-sans-first:112210.85 09:00:04 INFO - PROCESS | 17753 | Values: 591.3 610.1 628.3 638.3 652.3 33522.8 34044.5 44153.8 45173.1 45215.8 43513.0 46963.5 47387.5 47394.3 47523.5 8155.9 9131.8 9300.1 9300.3 9302.0 8308.7 10877.5 11113.1 11113.3 11569.9 11269.7 11350.1 11356.8 11357.3 11361.0 10664.8 10721.7 10727.5 10729.5 10734.2 11014.0 11106.7 11106.8 11109.1 11111.2 44047.1 44185.3 44271.0 44422.6 44429.6 3558.2 3643.0 3691.6 3878.5 4017.7 34334.7 34456.3 34485.7 34634.5 34830.8 4656.8 4705.4 4731.6 4742.3 4747.6 337073.0 337765.0 339292.0 339522.0 339567.0 60145.7 60378.0 60458.7 60498.0 60523.1 38894.8 39475.0 39564.6 41693.8 41989.7 17549.5 17722.4 17747.7 17759.1 17770.7 12038.3 12258.1 13170.7 13493.9 13606.8 20250.9 20263.2 20420.2 20421.9 20425.6 7402.9 7597.9 7632.6 7644.4 7698.3 950.3 1096.4 1106.9 1109.8 1176.4 32105.4 34603.3 34867.0 36337.0 36621.0 1164.4 1176.0 1176.4 1204.6 1227.6 16042.8 16441.0 16505.7 16716.9 17013.1 479104.0 489937.0 490093.0 491538.0 492124.0 61600.0 62237.0 62250.7 62330.4 62399.0 1334.3 1342.4 1370.8 1455.5 1483.0 30165.7 33987.0 34053.5 34234.3 34645.3 53287.2 53667.0 53847.2 53900.0 53902.5 429626.0 432772.0 433928.0 434318.0 435088.0 45777.0 46627.6 46846.3 47173.3 47241.0 49412.5 50861.2 50896.0 51263.7 51355.2 43135.8 43184.8 43557.0 43656.8 45405.1 42513.0 43095.1 43546.1 43651.3 43782.3 42194.2 42901.4 42908.6 42924.1 43156.4 35837.5 37860.8 38174.8 38382.2 39083.0 28241.5 28743.7 28795.4 28870.6 28988.9 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#2] jquery.html Cycles:180 Average:29523.38 Median:429.45 stddev:81658.57 (19014.9%) stddev-sans-first:81858.38 09:00:04 INFO - PROCESS | 17753 | Values: 405.6 410.4 424.4 434.5 445.4 19037.1 19488.6 20812.9 20843.5 20987.6 18834.4 19330.2 19897.8 20067.1 20093.0 5744.2 6018.1 6019.7 6026.7 6041.1 5707.0 5904.2 5930.1 5967.0 5973.2 6028.7 6032.5 6034.0 6035.1 6038.7 5836.9 5964.6 6008.6 6010.2 6030.8 5825.3 5844.8 5846.7 5851.0 5854.6 13802.2 14139.4 14164.9 14369.4 14473.5 2449.3 2497.0 2524.1 2548.2 2917.4 10759.9 10836.2 11915.2 14053.9 15498.2 1774.3 1916.6 1916.9 1918.9 1931.7 79475.0 83481.0 83601.6 84730.0 85674.6 11487.4 11750.0 11860.2 11931.6 11974.8 16933.3 16945.2 17024.5 17050.3 17052.6 8331.7 8354.6 8396.4 8514.6 8524.4 7808.4 7905.4 8028.6 8111.0 8137.0 4501.5 4506.4 4982.3 5083.8 5199.4 1947.6 1950.6 1966.9 2014.7 2023.2 882.9 971.3 977.6 995.7 1023.8 19381.3 20486.6 20752.8 20842.4 20977.2 942.1 953.5 978.1 982.4 1020.9 10739.9 11290.4 11319.2 11326.0 11537.1 486150.0 494151.0 498330.1 498483.0 499907.0 74406.6 75705.0 95803.5 96750.5 99988.5 967.3 994.1 996.0 997.9 1007.4 17037.5 17950.0 18050.6 18404.6 18606.8 45538.3 45636.0 45998.0 46220.1 46311.5 57467.7 61450.7 62502.0 63371.0 64497.7 9000.8 9317.3 9343.6 9384.6 9476.9 12280.6 14302.6 14446.8 14588.9 14596.5 11932.9 12122.6 12204.9 12310.1 12459.5 11884.0 12265.4 12293.6 12437.4 12610.6 12000.8 12141.2 12212.8 12349.9 12507.1 9080.6 9129.9 9159.0 9250.6 9970.6 11972.2 12208.5 12353.6 12392.1 12404.1 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#3] mootools.html Cycles:180 Average:5724.75 Median:4768.13 stddev:3290.11 (69.0%) stddev-sans-first:3283.32 09:00:04 INFO - PROCESS | 17753 | Values: 1404.8 1485.4 1582.5 1610.9 1776.1 8362.7 9032.7 9036.0 9045.1 9046.3 7580.4 7850.1 8470.3 8754.0 8873.7 2397.4 2426.3 2428.5 2431.3 2436.0 2386.7 2387.0 2423.9 2426.7 2426.9 2356.3 2372.0 2372.7 2381.5 2388.8 2313.1 2318.4 2319.0 2319.8 2369.2 2323.5 2335.1 2338.1 2340.2 2342.1 8494.7 8664.0 8667.5 8669.0 8670.4 5207.8 5337.8 5343.9 5346.4 5350.3 3235.3 3277.2 3333.3 3340.7 3341.1 1113.2 1113.4 1118.4 1141.9 1154.5 12195.3 12211.5 12223.1 12235.6 12252.1 4396.3 4428.0 4584.8 4590.5 4631.7 10478.8 10490.1 10490.1 10495.0 10500.5 5296.7 5309.1 5315.3 5350.8 5351.0 4103.6 4187.8 4244.8 4726.0 4861.5 3749.2 3855.0 3919.6 3949.2 4037.8 1222.2 1223.3 1224.1 1242.7 1242.7 726.3 839.3 845.6 847.9 860.8 5628.1 5639.5 5683.9 5727.7 5767.6 946.1 995.7 996.0 997.6 1010.2 3630.0 3664.2 3775.8 3830.8 3946.9 10717.7 11122.4 11127.2 11135.9 11189.4 11007.4 11016.3 11023.2 11041.7 11090.9 8010.0 8415.5 8426.9 8441.3 8479.5 5617.5 5635.5 5759.3 5786.0 5838.8 9439.4 9498.2 9520.4 9976.0 10063.2 10221.5 10278.0 10441.6 10474.5 10483.4 7346.6 7521.6 7541.4 7544.2 7548.8 8180.2 8222.1 8226.0 8231.5 8236.2 7178.3 7199.7 7211.2 7339.0 7446.0 7351.5 7437.1 7452.7 7550.7 7679.8 6989.5 7089.9 7090.7 7100.0 7103.4 4810.2 4825.1 4885.1 4887.6 5024.8 4878.4 4891.4 4978.9 4983.4 5023.8 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#4] prototype.html Cycles:180 Average:4883.80 Median:5525.13 stddev:1434.87 (26.0%) stddev-sans-first:1397.52 09:00:04 INFO - PROCESS | 17753 | Values: 325.8 335.2 337.2 342.7 352.0 5284.4 5438.8 5475.4 5506.5 5514.6 5316.6 5418.4 5442.7 5450.8 5463.8 4339.4 4349.4 4350.1 4358.0 4378.4 4246.8 4295.9 4338.7 4362.6 4369.3 4331.6 4331.7 4340.6 4349.4 4350.8 4313.9 4336.8 4343.8 4346.3 4358.9 3585.6 3886.6 3912.7 3913.8 3916.6 5303.8 5316.8 5318.6 5346.4 5375.2 4917.4 4921.0 4922.8 4940.7 4958.0 5526.9 5717.9 5750.8 5760.6 5766.9 4176.6 4177.3 4180.4 4181.6 4188.1 5966.9 5983.9 6014.3 6016.7 6110.3 4085.3 4202.8 4223.6 4234.7 4274.3 4331.0 4350.6 4356.6 4358.8 4366.3 4874.0 4905.2 4906.5 4906.5 4914.2 5634.6 5779.7 5796.2 5827.5 5877.7 1358.9 1382.3 1385.2 1386.7 1387.9 994.4 1017.2 1030.6 1043.7 1044.4 5561.4 5565.4 5575.9 5578.7 5580.7 5772.2 5822.0 5840.7 5852.9 5878.8 5399.4 5523.4 5550.3 5560.5 5637.6 3133.8 3167.2 3173.8 3177.4 3179.4 5980.7 6118.6 6128.8 6187.3 6194.7 6017.8 6037.5 6075.6 6075.6 6081.2 6119.9 6129.2 6130.6 6132.7 6200.3 5634.5 5950.7 5955.9 5969.8 6047.5 5898.6 5903.8 5914.0 5925.4 5930.9 5860.8 6149.8 6190.4 6194.9 6202.8 4208.7 4247.0 4265.8 4279.9 4283.7 6012.2 6014.2 6022.8 6076.9 6090.2 5680.7 5722.6 5732.5 5821.6 5845.7 5801.2 5817.8 5823.7 5827.7 5830.4 5678.7 5736.6 5773.4 5796.1 5836.8 5810.0 5821.2 5864.0 5865.5 5875.3 5713.1 5717.8 5719.6 5735.8 5772.8 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - PROCESS | 17753 | [#5] yui.html Cycles:180 Average:21628.84 Median:4126.91 stddev:31109.28 (753.8%) stddev-sans-first:31156.93 09:00:04 INFO - PROCESS | 17753 | Values: 719.3 770.9 785.4 798.7 869.7 15015.5 15944.4 16385.2 16653.0 16725.3 14517.3 14632.3 14680.4 14691.5 14716.5 547.1 585.3 589.1 679.5 721.6 594.9 596.8 597.9 598.3 598.4 621.7 624.4 624.4 625.0 625.2 620.6 621.7 622.4 623.2 623.3 454.6 454.8 454.9 455.0 455.1 14754.2 14760.0 14760.6 14767.7 14798.6 16240.5 16292.6 16342.0 16486.5 16923.9 12817.2 12966.7 13057.7 13222.7 13571.5 3942.4 3962.3 3972.9 4119.6 4134.2 88717.6 88781.6 90071.5 90331.0 93169.5 12157.6 12390.2 12415.9 12991.0 13616.7 22661.4 23781.2 24605.5 24622.5 24763.5 8734.9 8775.3 9244.6 9322.3 9624.4 4808.3 4826.5 4837.5 4965.7 5255.9 3525.7 3620.6 3646.0 3651.7 3654.1 601.8 602.8 609.4 609.7 614.6 635.6 642.7 652.7 663.0 681.1 8983.4 9491.4 9722.1 9804.2 9992.6 644.6 650.3 655.5 667.1 693.8 4434.4 4614.9 4762.0 4801.7 4821.1 100476.0 101393.0 128821.4 132891.0 133071.0 60549.0 99350.0 100788.5 101015.5 105148.0 83087.2 83655.0 83719.3 89197.0 91555.5 9901.5 10349.2 10468.6 10482.0 10544.0 47854.8 54921.5 55314.9 56925.4 57524.4 68734.0 77163.6 77338.0 77846.0 83352.2 13345.2 13648.3 13684.7 13708.4 13832.2 14604.6 14765.6 15143.1 15181.5 16158.4 13727.9 14374.9 14596.3 14666.1 14957.9 13826.7 14028.3 14389.1 14407.1 14733.1 13030.3 13390.1 13459.4 13518.7 13573.9 11063.6 11084.4 11830.6 12393.9 12945.7 10757.8 10966.6 11205.5 11646.3 12070.5 09:00:04 INFO - PROCESS | 17753 | -------- Summary: end -------- 09:00:04 INFO - PROCESS | 17753 | 09:00:04 INFO - TEST-INFO | 17753: exit 0 09:00:05 INFO - TEST-OK | dromaeo_css | took 1113845ms 09:00:05 INFO - TEST-START | kraken 09:00:05 INFO - operating with platform_type : linux_ 09:00:05 INFO - Initialising browser for kraken test... 09:00:05 INFO - TEST-INFO | started process 18054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7xylj/profile http://localhost:60072/getInfo.html) 09:00:09 INFO - PROCESS | 18054 | __metrics Screen width/height:1600/1200 09:00:09 INFO - PROCESS | 18054 | colorDepth:24 09:00:09 INFO - PROCESS | 18054 | Browser inner width/height: 1024/697 09:00:09 INFO - PROCESS | 18054 | __metrics 09:00:09 INFO - PROCESS | 18054 | 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" 09:00:09 INFO - PROCESS | 18054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:10 INFO - PROCESS | 18054 | console.error: PushService: 09:00:10 INFO - PROCESS | 18054 | stateChangeProcessEnqueue: Error transitioning state 09:00:10 INFO - PROCESS | 18054 | UnknownError 09:00:10 INFO - TEST-INFO | 18054: exit 0 09:00:10 INFO - Browser initialized. 09:00:10 INFO - Running cycle 1/1 for kraken test... 09:00:10 INFO - TEST-INFO | started process 18145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7xylj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:22 INFO - PROCESS | 18145 | RSS: Main: 143261696 09:00:22 INFO - PROCESS | 18145 | 09:00:25 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:25 INFO - PROCESS | 18145 | RSS: Main: 186810368 09:00:25 INFO - PROCESS | 18145 | 09:00:28 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-dft) 09:00:29 INFO - PROCESS | 18145 | RSS: Main: 173826048 09:00:29 INFO - PROCESS | 18145 | 09:00:31 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-fft) 09:00:32 INFO - PROCESS | 18145 | RSS: Main: 265723904 09:00:32 INFO - PROCESS | 18145 | 09:00:34 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-oscillator) 09:00:35 INFO - PROCESS | 18145 | RSS: Main: 172638208 09:00:35 INFO - PROCESS | 18145 | 09:00:37 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:37 INFO - PROCESS | 18145 | RSS: Main: 173314048 09:00:37 INFO - PROCESS | 18145 | 09:00:40 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:41 INFO - PROCESS | 18145 | RSS: Main: 209760256 09:00:41 INFO - PROCESS | 18145 | 09:00:44 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:45 INFO - PROCESS | 18145 | RSS: Main: 208605184 09:00:45 INFO - PROCESS | 18145 | 09:00:48 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60072/tests/kraken/driver.html?testName=json-parse-financial) 09:00:48 INFO - PROCESS | 18145 | RSS: Main: 208957440 09:00:48 INFO - PROCESS | 18145 | 09:00:50 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60072/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:50 INFO - PROCESS | 18145 | RSS: Main: 170938368 09:00:50 INFO - PROCESS | 18145 | 09:00:52 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:53 INFO - PROCESS | 18145 | RSS: Main: 178413568 09:00:53 INFO - PROCESS | 18145 | 09:00:55 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:55 INFO - PROCESS | 18145 | RSS: Main: 187457536 09:00:55 INFO - PROCESS | 18145 | 09:00:58 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:58 INFO - PROCESS | 18145 | RSS: Main: 196620288 09:00:58 INFO - PROCESS | 18145 | 09:01:01 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:02 INFO - PROCESS | 18145 | RSS: Main: 193224704 09:01:02 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60072/tests/kraken/driver.html?testName=ai-astar) 09:01:03 INFO - PROCESS | 18145 | RSS: Main: 243793920 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | __start_tp_report 09:01:03 INFO - PROCESS | 18145 | _x_x_mozilla_page_load 09:01:03 INFO - PROCESS | 18145 | _x_x_mozilla_page_load_details 09:01:03 INFO - PROCESS | 18145 | |i|pagename|runs| 09:01:03 INFO - PROCESS | 18145 | |0;ai-astar;111;110;110;111;111;111;109;110;110;110 09:01:03 INFO - PROCESS | 18145 | |1;audio-beat-detection;143;117;116;159;120;119;121;117;144;116 09:01:03 INFO - PROCESS | 18145 | |2;audio-dft;161;160;163;162;161;160;162;160;160;159 09:01:03 INFO - PROCESS | 18145 | |3;audio-fft;76;75;80;116;78;76;75;75;108;74 09:01:03 INFO - PROCESS | 18145 | |4;audio-oscillator;81;80;115;81;81;81;112;82;82;114 09:01:03 INFO - PROCESS | 18145 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;116 09:01:03 INFO - PROCESS | 18145 | |6;imaging-darkroom;147;145;146;145;146;146;146;146;145;146 09:01:03 INFO - PROCESS | 18145 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;94;95 09:01:03 INFO - PROCESS | 18145 | |8;json-parse-financial;50;51;50;51;51;53;51;50;53;49 09:01:03 INFO - PROCESS | 18145 | |9;json-stringify-tinderbox;60;60;60;60;59;59;64;61;60;63 09:01:03 INFO - PROCESS | 18145 | |10;stanford-crypto-aes;74;75;82;75;73;82;76;81;72;72 09:01:03 INFO - PROCESS | 18145 | |11;stanford-crypto-ccm;124;126;123;123;130;122;130;120;168;122 09:01:03 INFO - PROCESS | 18145 | |12;stanford-crypto-pbkdf2;157;158;156;154;154;156;156;156;153;154 09:01:03 INFO - PROCESS | 18145 | |13;stanford-crypto-sha256-iterative;63;63;63;62;61;66;62;62;62;61 09:01:03 INFO - PROCESS | 18145 | __end_tp_report 09:01:03 INFO - PROCESS | 18145 | __start_cc_report 09:01:03 INFO - PROCESS | 18145 | _x_x_mozilla_cycle_collect,1592 09:01:03 INFO - PROCESS | 18145 | __end_cc_report 09:01:03 INFO - PROCESS | 18145 | __startTimestamp1484154063954__endTimestamp 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | ------- Summary: start ------- 09:01:03 INFO - PROCESS | 18145 | Number of tests: 14 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:01:03 INFO - PROCESS | 18145 | Values: 111.0 110.0 110.0 111.0 111.0 111.0 109.0 110.0 110.0 110.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:120.50 stddev:15.49 (12.9%) stddev-sans-first:15.34 09:01:03 INFO - PROCESS | 18145 | Values: 143.0 117.0 116.0 159.0 120.0 119.0 121.0 117.0 144.0 116.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 09:01:03 INFO - PROCESS | 18145 | Values: 161.0 160.0 163.0 162.0 161.0 160.0 162.0 160.0 160.0 159.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:15.34 (20.3%) stddev-sans-first:16.04 09:01:03 INFO - PROCESS | 18145 | Values: 76.0 75.0 80.0 116.0 78.0 76.0 75.0 75.0 108.0 74.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:81.00 stddev:15.74 (19.4%) stddev-sans-first:16.28 09:01:03 INFO - PROCESS | 18145 | Values: 81.0 80.0 115.0 81.0 81.0 81.0 112.0 82.0 82.0 114.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:01:03 INFO - PROCESS | 18145 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 09:01:03 INFO - PROCESS | 18145 | Values: 147.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 09:01:03 INFO - PROCESS | 18145 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.29 (2.5%) stddev-sans-first:1.32 09:01:03 INFO - PROCESS | 18145 | Values: 50.0 51.0 50.0 51.0 51.0 53.0 51.0 50.0 53.0 49.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 09:01:03 INFO - PROCESS | 18145 | Values: 60.0 60.0 60.0 60.0 59.0 59.0 64.0 61.0 60.0 63.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.50 stddev:3.99 (5.3%) stddev-sans-first:4.16 09:01:03 INFO - PROCESS | 18145 | Values: 74.0 75.0 82.0 75.0 73.0 82.0 76.0 81.0 72.0 72.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:125.00 stddev:14.17 (11.3%) stddev-sans-first:14.92 09:01:03 INFO - PROCESS | 18145 | Values: 124.0 126.0 123.0 123.0 130.0 122.0 130.0 120.0 168.0 122.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:1.58 (1.0%) stddev-sans-first:1.56 09:01:03 INFO - PROCESS | 18145 | Values: 157.0 158.0 156.0 154.0 154.0 156.0 156.0 156.0 153.0 154.0 09:01:03 INFO - PROCESS | 18145 | 09:01:03 INFO - PROCESS | 18145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.51 09:01:03 INFO - PROCESS | 18145 | Values: 63.0 63.0 63.0 62.0 61.0 66.0 62.0 62.0 62.0 61.0 09:01:03 INFO - PROCESS | 18145 | -------- Summary: end -------- 09:01:03 INFO - PROCESS | 18145 | 09:01:04 INFO - TEST-INFO | 18145: exit 0 09:01:05 INFO - TEST-OK | kraken | took 60009ms 09:01:05 INFO - SUITE-END | took 1173s 09:01:05 INFO - Completed test suite (00:19:33) 09:01:05 INFO - javascript benchmark 09:01:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.969570304297, 3081.9383612327747, 3095.117891400951, 3120.3759248150377, 3121.3601211751593, 5369.140937450009, 5432.239486471892, 5453.863653408666, 5454.10007348788, 5482.068048431766, 5429.348478182614, 5429.809956651518, 5456.454354564542, 5463.180522921563, 5479.917801232975, 4956.553910148095, 4991.775370108336, 5017.122003649365, 5076.263941728447, 5082.898342033157, 4892.510748925097, 5019.14674505335, 5075.06111369396, 5075.264086707425, 5076.746162691869, 4885.511448855122, 4923.310736496894, 4993.725345106018, 4998.375203099613, 5019.222020586815, 5033.949660503403, 5061.772220250097, 5071.898562028776, 5144.768485418165, 5175.120229560984, 5007.974960125176, 5021.422536408323, 5098.59211263098, 5107.259447380146, 5113.667611605271, 5106.540411362958, 5213.061648903196, 5263.0, 5289.788408463657, 5316.707581083039, 5742.368339482654, 5778.0466223073145, 5783.797567085174, 5847.502962248214, 5851.180834683148, 5892.499137573312, 5893.734781934823, 5896.292444906639, 5905.940940590582, 5910.202122713422, 5264.394594621591, 5321.148616221425, 5354.9196762048605, 5411.188321751769, 5445.50990410857, 6015.819525414245, 6021.157038014681, 6039.426254505903, 6039.486643635252, 6040.728167232485, 5784.566157538202, 5784.942150578525, 5785.681787501728, 5788.247527821356, 5789.305283366023, 5527.336719593594, 5578.9163162552595, 5707.800226992035, 5753.971230143822, 5754.971225143848, 5767.971160144172, 5769.769209231584, 5771.653700777967, 5775.133729940542, 5793.8841223175305, 5748.511376533042, 5799.3620701722775, 5804.709764511757, 5805.36141024487, 5830.7084645767545, 4371.213181627274, 4411.823527058882, 4450.666200035011, 4485.955140448554, 4513.232750432434, 3978.6817054635558, 4030.496187976503, 4050.736702114353, 4051.0682543015273, 4063.045184381668, 5574.498295153456, 5578.748956296977, 5580.441955804387, 5581.609287349927, 5582.8325150245555, 5621.7189140542805, 5674.0, 5688.11834165705, 5874.559408044413, 5877.294724633071, 5443.0, 5486.780528778804, 5507.366652834895, 5522.364928033247, 5537.889242215133, 5027.1956486962645, 5036.219385995177, 5039.294498770175, 5055.418626857885, 5060.873478163076, 5752.252207213036, 5756.94243057564, 5940.405959404025, 5942.821715348547, 5956.612820166675, 5744.281964754406, 5765.077587585966, 5772.018756811268, 5815.738291776965, 5820.359760426434, 5976.9103463448955, 5982.132590774227, 5984.611000284967, 5986.970065149646, 5992.940070599413, 5488.341399032141, 5728.4271572844045, 5728.455796699307, 5740.483356497768, 5746.482816546531, 5609.411011843697, 5743.9138412923, 5774.653520788766, 5788.27646544182, 5879.941200587939, 5715.685637289989, 5717.742701578356, 5718.628289161191, 5719.599628025998, 5722.713864306685, 5609.887802244014, 5708.54331653475, 5717.799877004451, 5722.62802917809, 5728.054870946247, 5494.2582751328055, 5533.861653458695, 5607.074832652566, 5626.015447296625, 5676.68778217202, 5807.041838096667, 5816.70916454184, 5818.94181058184, 5821.446962538552, 5822.388649191943, 5417.51242388187, 5677.205191273142, 5678.545716342765, 5685.317761868602, 5693.686847223443], "value": 5365.805935576852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2609238451935, 610.1397030187435, 628.2680677011283, 638.250056183984, 652.2922628947591, 33522.83238583807, 34044.48933266, 44153.7792311038, 45173.09653806922, 45215.77392113043, 43513.0, 46963.53036469643, 47387.52612473874, 47394.28908566366, 47523.52476475234, 8155.918440815575, 9131.771705707377, 9300.11648893354, 9300.302477314195, 9302.0, 8308.70919517817, 10877.456127193609, 11113.110951123932, 11113.277636953571, 11569.884301157006, 11269.66191014271, 11350.09199264057, 11356.829647555292, 11357.261777984404, 11361.0, 10664.840027399596, 10721.678349649523, 10727.463626818628, 10729.517171727291, 10734.194935379839, 11014.0, 11106.666799996014, 11106.777864442665, 11109.111271098292, 11111.222214444992, 44047.11905761899, 44185.33721994173, 44271.0, 44422.55577444217, 44429.555704442864, 3558.19940513385, 3643.03459583208, 3691.593924668284, 3878.5151856017997, 4017.738846974937, 34334.656653433645, 34456.310873782386, 34485.65514344849, 34634.48048279278, 34830.82584587086, 4656.813727450898, 4705.364775755298, 4731.621470282369, 4742.264948932921, 4747.596454301389, 337072.99999999756, 337765.0, 339292.0, 339522.0, 339567.0, 60145.69927150336, 60378.0, 60458.697706511186, 60498.0, 60523.092153617734, 38894.80552597219, 39475.0, 39564.60435395667, 41693.79153104215, 41989.74030779082, 17549.473515794547, 17722.379716709853, 17747.73378399325, 17759.112044397727, 17770.733438998166, 12038.33789141588, 12258.08064395174, 13170.736585268241, 13493.865061349457, 13606.795898061537, 20250.89874550618, 20263.189472421232, 20420.183192672128, 20421.89789051075, 20425.591488170154, 7402.888956665654, 7597.924020759832, 7632.580208088498, 7644.426667999922, 7698.34564062061, 950.273041123541, 1096.4188979840696, 1106.9280496767685, 1109.778044391125, 1176.3823992404057, 32105.357892842014, 34603.307933841184, 34867.0, 36337.0, 36621.0, 1164.3654208456412, 1175.9710253528162, 1176.353005846781, 1204.5543149034913, 1227.5887577661583, 16042.839571604369, 16441.0, 16505.6698866022, 16716.916415417843, 17013.14934253307, 479104.0, 489937.0, 490093.0, 491538.0, 492124.0, 61600.0, 62237.0, 62250.68874655688, 62330.37669623336, 62399.0, 1334.252818421687, 1342.3757952551914, 1370.7806750919806, 1455.4978532406303, 1482.992585037068, 30165.698343017168, 33987.0, 34053.48919766156, 34234.31531369408, 34645.307093858486, 53287.20069198887, 53667.0, 53847.192292114865, 53900.0, 53902.460975389746, 429626.0, 432772.0, 433928.0, 434318.0, 435088.0, 45777.0, 46627.57038081377, 46846.29730553976, 47173.29240061333, 47241.0, 49412.50587494079, 50861.23708144307, 50896.0, 51263.743681281354, 51355.22967155421, 43135.784321078194, 43184.78407607942, 43557.0, 43656.78171609122, 45405.09189816119, 42513.0, 43095.13809723851, 43546.12907741891, 43651.34522982221, 43782.34326485169, 42194.156116876875, 42901.356479652204, 42908.570914291704, 42924.14151716886, 43156.352654710834, 35837.46243806397, 37860.81069594635, 38174.80912595419, 38382.23235535218, 39083.0, 28241.50314477835, 28743.71256287494, 28795.42409151847, 28870.566941496316, 28988.855055724587], "value": 21261.956938347586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.61263992886796, 410.3905700035445, 424.3549804297468, 434.5372178629758, 445.4098319726363, 19037.143328550213, 19488.610227795452, 20812.89593552034, 20843.478913027182, 20987.580248395025, 18834.43496695098, 19330.226790928347, 19897.801021989777, 20067.09698063587, 20092.995350232504, 5744.195812586241, 6018.097285407202, 6019.729112189962, 6026.698665066751, 6041.124037014631, 5706.971465142689, 5904.173415721781, 5930.110483427477, 5966.970165149168, 5973.22348094747, 6028.728707208186, 6032.517398608101, 6033.969830150843, 6035.124906888498, 6038.667873266969, 5836.883262334751, 5964.582479226456, 6008.579399442041, 6010.248718910092, 6030.849228769294, 5825.271841019872, 5844.766209351621, 5846.7076646167525, 5850.97074514629, 5854.560907931879, 13802.240876751775, 14139.434422623082, 14164.85835141656, 14369.353379097862, 14473.493427729978, 2449.2652204338806, 2497.0261597976805, 2524.0534799450206, 2548.24826676131, 2917.401932603811, 10759.946200268949, 10836.187285953585, 11915.165938384316, 14053.859461405358, 15498.225088745517, 1774.308019872251, 1916.568772026297, 1916.9424917252504, 1918.856085793571, 1931.690929451295, 79475.0, 83481.0, 83601.58199209026, 84730.0, 85674.57162714208, 11487.42562871853, 11750.0, 11860.22908510944, 11931.642050738492, 11974.820377694341, 16933.322667093424, 16945.237464314134, 17024.48926532206, 17050.317987280618, 17052.573685657957, 8331.708390206313, 8354.58227088643, 8396.370272229608, 8514.616842242114, 8524.445911015888, 7808.41436892224, 7905.407094467938, 8028.638711258008, 8111.0, 8137.0, 4501.48232953208, 4506.414166158378, 4982.327385802871, 5083.754480152386, 5199.376074870964, 1947.6202140582734, 1950.5806251655963, 1966.852486063551, 2014.6602509331424, 2023.2311721546014, 882.9072947340566, 971.3152227679469, 977.5747549815853, 995.7261753017978, 1023.8452064754458, 19381.321653742052, 20486.59026819455, 20752.792472075085, 20842.37472875816, 20977.160913563286, 942.1426501883391, 953.4708236928433, 978.0854900667756, 982.4400091947664, 1020.8774947006407, 10739.946300268448, 11290.378577840926, 11319.151063670257, 11326.0, 11537.134714896416, 486150.0, 494151.0, 498330.0834958238, 498483.0, 499907.0, 74406.6279668609, 75705.0, 95803.52098239603, 96750.51624741971, 99988.50005749924, 967.2793768642266, 994.1202036198017, 995.9542480395555, 997.9201663866874, 1007.3552926127285, 17037.48887533376, 17950.0, 18050.638987220445, 18404.63190736151, 18606.81393186051, 45538.31692524681, 45636.0, 45998.0, 46220.07559848851, 46311.536884630725, 57467.712661436424, 61450.692746535984, 62502.0, 63371.0, 64497.67751161214, 9000.819983600422, 9317.301202409712, 9343.626254949726, 9384.57769400365, 9476.85784713216, 12280.570180043656, 14302.642433939234, 14446.783298250744, 14588.85411145875, 14596.489122880648, 11932.940335298268, 12122.636320910387, 12204.87795122073, 12310.138290319592, 12459.501619935101, 11884.039133542869, 12265.448054837732, 12293.631191064282, 12437.378131093228, 12610.558630448257, 12000.819987700366, 12141.150119491904, 12212.816807748068, 12349.93825030869, 12507.061970352443, 9080.591373388346, 9129.863052054092, 9158.95420522893, 9250.583723732583, 9970.601175952881, 11972.221805582609, 12208.45061972231, 12353.62939111828, 12392.070594705614, 12404.131710780159], "value": 9501.997904312811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.8033275341452, 1485.3835658201847, 1582.5489735425392, 1610.9275082621282, 1776.1385727921947, 8362.749117526477, 9032.72901812946, 9036.0, 9045.050269721683, 9046.321525885553, 7580.431467639935, 7850.136484986647, 8470.322374210064, 8754.0, 8873.73378798637, 2397.364698354933, 2426.2842461473906, 2428.4657375377387, 2431.3435372449517, 2435.9756402436014, 2386.713594368678, 2387.0, 2423.9272821815284, 2426.696662917135, 2426.9271921842374, 2356.3284463927785, 2372.0156135203956, 2372.727136379321, 2381.4641705616273, 2388.8327817052814, 2313.1210140146723, 2318.3508617587186, 2319.0375993962484, 2319.7912187903084, 2369.206315884164, 2323.4772176260376, 2335.100986120339, 2338.1232037985756, 2340.180936672168, 2342.0631747301045, 8494.74515764528, 8664.0, 8667.523286219255, 8669.0, 8670.436421632574, 5207.765650545734, 5337.8131765388025, 5343.866403339909, 5346.358436987547, 5350.250964864883, 3235.3367559650214, 3277.246233366315, 3333.283344081034, 3340.6993370596765, 3341.097903566048, 1113.2318700096907, 1113.4377139544558, 1118.429600903545, 1141.8915203055778, 1154.5035634677085, 12195.329256890867, 12211.45048472812, 12223.14437989341, 12235.571754988532, 12252.14235003559, 4396.252637051709, 4428.0, 4584.816607335736, 4590.495045544987, 4631.745254011062, 10478.842817357745, 10490.05589496949, 10490.05589496949, 10495.0, 10500.47497625131, 5296.655717378358, 5309.070912590359, 5315.335583052119, 5350.839474815684, 5351.03681337363, 4103.569125241806, 4187.769672668032, 4244.830206791756, 4726.03116361152, 4861.465238823726, 3749.1751814600743, 3855.0, 3919.6080391960577, 3949.2101579684177, 4037.7981100944835, 1222.1872454817624, 1223.3455101520822, 1224.1430998301046, 1242.658268976039, 1242.7203879127305, 726.3063774095726, 839.261449924063, 845.6490556419141, 847.9364047696447, 860.7934095816959, 5628.127640215773, 5639.548836093103, 5683.886322273532, 5727.742251598688, 5767.625104368202, 946.1342871272846, 995.7361299255703, 995.9502024898726, 997.5631665930471, 1010.2322235101229, 3630.0, 3664.193877346979, 3775.8300876460626, 3830.8467661293234, 3946.940795888064, 10717.678469645924, 11122.443877806078, 11127.221094523467, 11135.888641113646, 11189.384583847805, 11007.394593297286, 11016.339019658846, 11023.17326200538, 11041.668749937515, 11090.944545277222, 8010.0, 8415.537145456936, 8426.915730842737, 8441.282490988335, 8479.491230526188, 5617.494425501724, 5635.549156067586, 5759.280089988752, 5785.971070144622, 5838.824835254779, 9439.386439881386, 9498.19265362452, 9520.381175223589, 9975.950120249352, 10063.245256605931, 10221.488925553544, 10278.0, 10441.63454279127, 10474.52864621109, 10483.37099774016, 7346.632668366454, 7521.586312752632, 7541.43439242048, 7544.207858175032, 7548.773536793905, 8180.222878826502, 8222.095569487472, 8226.0, 8231.547264900488, 8236.217559331853, 7178.318059784312, 7199.748008819666, 7211.2428195038765, 7339.0, 7445.957565940665, 7351.485396022227, 7437.107547094383, 7452.701891924479, 7550.6786312394015, 7679.808004799925, 6989.510734248757, 7089.893651595334, 7090.680919358538, 7100.0, 7103.396211322096, 4810.230363141881, 4825.10735513931, 4885.145099607484, 4887.633427493023, 5024.799008039638, 4878.438979517401, 4891.437484689306, 4978.850634480971, 4983.352164218773, 5023.799048038038], "value": 4572.915756727115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.83219641884426, 335.1905149065008, 337.2075622287624, 342.67617101838755, 351.9542459480267, 5284.44513326101, 5438.755256013479, 5475.397706252309, 5506.531944784693, 5514.6139770216105, 5316.574674026078, 5418.4039755626945, 5442.673439593627, 5450.836474905759, 5463.808766693167, 4339.414179085815, 4349.41282926804, 4350.129974005195, 4357.956420435795, 4378.35811570661, 4246.787660616972, 4295.871123866289, 4338.696291259613, 4362.629176519999, 4369.3227549729845, 4331.588499092597, 4331.65346772259, 4340.587644173798, 4349.41282926804, 4350.825966961318, 4313.892152696177, 4336.8265269389185, 4343.761093139876, 4346.304591265382, 4358.912821743547, 3585.623509531488, 3886.639676113366, 3912.6674232690257, 3913.8434462621462, 3916.5887581803786, 5303.840884773463, 5316.840494785162, 5318.574514038867, 5346.4118946915805, 5375.193720941851, 4917.385326834145, 4920.975395123037, 4922.778474968635, 4940.728259945701, 4958.0, 5526.861828454281, 5717.914231286534, 5750.7987220447085, 5760.567957403169, 5766.884662306772, 4176.62410383064, 4177.3316269396755, 4180.393842892763, 4181.6236538711355, 4188.099558594917, 5966.910496342558, 5983.910241346383, 6014.278286605635, 6016.743721104585, 6110.266767987825, 4085.3463445849115, 4202.8232095013445, 4223.640990515779, 4234.724742891703, 4274.273373526508, 4330.956690433119, 4350.630196433339, 4356.564343565618, 4358.8038538265855, 4366.279563871989, 4874.0, 4905.23968784839, 4906.460289368167, 4906.484819094015, 4914.213725803854, 5634.577406694432, 5779.739911703983, 5796.1595568642315, 5827.475527202572, 5877.676727779927, 1358.8641135886332, 1382.2743059893435, 1385.217352196006, 1386.6671998720235, 1387.8959078069186, 994.3685759542742, 1017.1557607186018, 1030.5980667539666, 1043.6973277749519, 1044.383813550009, 5561.388247292794, 5565.359983601857, 5575.860603484864, 5578.748956296977, 5580.693061881636, 5772.181762744722, 5822.0, 5840.715042690601, 5852.941470585325, 5878.823635290948, 5399.406065332811, 5523.392426833045, 5550.250716153349, 5560.527355174774, 5637.605367624227, 3133.7649676274373, 3167.2081979505124, 3173.7778355514893, 3177.3645270945904, 3179.4277030134335, 5980.677048406743, 6118.6137406411535, 6128.785492507741, 6187.319394866561, 6194.690265486798, 6017.849553761191, 6037.456628903332, 6075.5747097703625, 6075.635461872213, 6081.209442772411, 6119.938800612026, 6129.172561704202, 6130.601510901777, 6132.662703551258, 6200.286966998853, 5634.464725851038, 5950.672713000653, 5955.91066134017, 5969.791057313147, 6047.5464340173785, 5898.613825751031, 5903.822885313448, 5914.0, 5925.4370834770625, 5930.881382372242, 5860.824175274749, 6149.7847575334645, 6190.380961903774, 6194.938050619617, 6202.782902598387, 4208.705390622627, 4247.023184667482, 4265.808038638331, 4279.935800962926, 4283.678724095643, 6012.248468941382, 6014.248218972629, 6022.76533310679, 6076.8784624308155, 6090.177825993434, 5680.665043714641, 5722.599418040697, 5732.455416735404, 5821.621594596338, 5845.678487683218, 5801.216835727123, 5817.76728930838, 5823.679697616672, 5827.737751801264, 5830.416958304136, 5678.74445649955, 5736.569757268138, 5773.422657734361, 5796.072628379439, 5836.795712150054, 5809.970950145223, 5821.1954294168945, 5864.0, 5865.477844526724, 5875.294964604275, 5713.085906254979, 5717.799877004285, 5719.599628025998, 5735.827925162085, 5772.797952071657], "value": 4422.306337494302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2950908110049, 770.9036370453694, 785.4227143049858, 798.7100832156068, 869.6825658634592, 15015.47445839396, 15944.36222551098, 16385.180740962966, 16653.0, 16725.330986760517, 14517.346719397627, 14632.268386580681, 14680.412783488675, 14691.485797997073, 14716.484923027696, 547.1218693996138, 585.3122580967367, 589.0957380421055, 679.5243329669252, 721.6211488968281, 594.9048152295634, 596.8000719758886, 597.8505373656586, 598.3209057719498, 598.4464370457309, 621.6953692690572, 624.3725056318393, 624.4286477872741, 625.046803624474, 625.2028663454109, 620.6214209332304, 621.6518749500294, 622.3714048810689, 623.155624129305, 623.3174673732256, 454.63856234293814, 454.8089802283016, 454.8976480291941, 454.9909001819945, 455.1170728786144, 14754.188519631416, 14760.040597361138, 14760.630984225372, 14767.704645907022, 14798.63003424923, 16240.512784616361, 16292.592685182846, 16342.0, 16486.505404837873, 16923.915380423143, 12817.23096614206, 12966.675833104247, 13057.738845223043, 13222.73554528904, 13571.524996625169, 3942.3889297158985, 3962.286788378091, 3972.9006774830573, 4119.588041195886, 4134.235166494208, 88717.55641221753, 88781.55609221978, 90071.54964225202, 90331.0, 93169.53415232948, 12157.635270941886, 12390.194637348724, 12415.93792031034, 12991.025673074557, 13616.727665446833, 22661.433464163198, 23781.167659131846, 24605.5078898421, 24622.507549848902, 24763.5047299053, 8734.86897696535, 8775.341849361323, 9244.630214791467, 9322.347435679438, 9624.422534647943, 4808.2547205183255, 4826.517348265145, 4837.467878533358, 4965.652404331734, 5255.947440525622, 3525.7003154731624, 3620.601733809279, 3646.033801042726, 3651.744377893575, 3654.14127679995, 601.8465291350677, 602.7860109661007, 609.4210500024994, 609.6738245038883, 614.563659801537, 635.5773410681845, 642.7236288395941, 652.6606164794281, 663.0352836622702, 681.0839420978775, 8983.416077954913, 9491.430514169171, 9722.098114556318, 9804.215662746963, 9992.550335234931, 644.6422235659161, 650.2554575011585, 655.5476721062452, 667.1194023888518, 693.7883945396602, 4434.379186913835, 4614.930776038362, 4761.952380476151, 4801.663883528189, 4821.083994041121, 100476.0, 101393.0, 128821.35589321994, 132891.0, 133071.0, 60549.0, 99350.0, 100788.49605751924, 101015.49492252491, 105148.0, 83087.16912830915, 83655.0, 83719.32733656636, 89197.0, 91555.54222228847, 9901.455419951972, 10349.223808214263, 10468.63359782404, 10482.0, 10544.0, 47854.760726196146, 54921.45078549163, 55314.89370212654, 56925.430745692014, 57524.42475575358, 68734.0, 77163.61418192873, 77338.0, 77846.0, 83352.16647833445, 13345.199288042748, 13648.301811567197, 13684.726305474034, 13708.3831227593, 13832.239226842621, 14604.561863144123, 14765.630859228606, 15143.091414515164, 15181.468648597245, 16158.434454794025, 13727.931360343135, 14374.928125359307, 14596.343164557833, 14666.120032798066, 14957.850421495647, 13826.723465530431, 14028.29858507091, 14389.136651800925, 14407.135571865721, 14733.116013039253, 13030.283334416697, 13390.129641573267, 13459.394327255493, 13518.729625407634, 13573.864261357656, 11063.557457701601, 11084.445777711244, 11830.585929492427, 12393.876061239273, 12945.705429456979, 10757.838632420677, 10966.616168434066, 11205.495752691311, 11646.301221926711, 12070.456829442872], "value": 7469.454551127655, "unit": "score"}], "name": "dromaeo_css", "value": 7396.7059605880295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 109.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 116.0, 159.0, 120.0, 119.0, 121.0, 117.0, 144.0, 116.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 161.0, 160.0, 162.0, 160.0, 160.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 80.0, 116.0, 78.0, 76.0, 75.0, 75.0, 108.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 115.0, 81.0, 81.0, 81.0, 112.0, 82.0, 82.0, 114.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 51.0, 53.0, 51.0, 50.0, 53.0, 49.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 64.0, 61.0, 60.0, 63.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 82.0, 75.0, 73.0, 82.0, 76.0, 81.0, 72.0, 72.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 123.0, 123.0, 130.0, 122.0, 130.0, 120.0, 168.0, 122.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 156.0, 154.0, 154.0, 156.0, 156.0, 156.0, 153.0, 154.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 61.0, 66.0, 62.0, 62.0, 62.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1464.6000000000001, "alertThreshold": 2.0}]} 09:01:05 INFO - Return code: 0 09:01:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:05 INFO - # TBPL SUCCESS # 09:01:05 INFO - Running post-action listener: _resource_record_post_action 09:01:05 INFO - [mozharness: 2017-01-11 17:01:05.251776Z] Finished run-tests step (success) 09:01:05 INFO - Running post-run listener: _resource_record_post_run 09:01:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 317825024; Read time: 68; Write time: 237780 09:01:05 INFO - TinderboxPrint: CPU usage
12.9% 09:01:05 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 68 09:01:05 INFO - TinderboxPrint: I/O write bytes / time
317,825,024 / 237,780 09:01:05 INFO - TinderboxPrint: CPU idle
8,260.1 (87.1%) 09:01:05 INFO - TinderboxPrint: CPU user
1,179.7 (12.4%) 09:01:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:05 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 100089856; Read time: 0; Write time: 107552 09:01:05 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 217735168; Read time: 0; Write time: 130228 09:01:05 INFO - Running post-run listener: _upload_blobber_files 09:01:05 INFO - Blob upload gear active. 09:01:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:05 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 09:01:05 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:05 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:08 INFO - (blobuploader) - INFO - Done attempting. 09:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:12 INFO - (blobuploader) - INFO - Done attempting. 09:01:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:12 INFO - (blobuploader) - INFO - Done attempting. 09:01:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:12 INFO - Return code: 0 09:01:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76a94a6db00f6fead82ed60c92e7491af61b0fb18315c5e2a5781cad7e2e301c3243c015ced8d2574e11b430873a52fbcd290048c2b2c4e0b09d417848511b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6fb90d58e3aeebb15ca2871db3f111fd32ec0c4e935ab0ce741b772dfa19066c166fcd230c502aa62ae9fe7aba42793da25a45d7782202bb8c2ea445b594446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b435891eeeda2b6b76366349f12bf90386f0cb03bc0fec6d9297cf047137fb0ea3f7ae47f4b35741deaf072d8333298dc177ec9c689d062efe0d564db75e65f"} 09:01:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:12 INFO - Contents: 09:01:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76a94a6db00f6fead82ed60c92e7491af61b0fb18315c5e2a5781cad7e2e301c3243c015ced8d2574e11b430873a52fbcd290048c2b2c4e0b09d417848511b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6fb90d58e3aeebb15ca2871db3f111fd32ec0c4e935ab0ce741b772dfa19066c166fcd230c502aa62ae9fe7aba42793da25a45d7782202bb8c2ea445b594446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b435891eeeda2b6b76366349f12bf90386f0cb03bc0fec6d9297cf047137fb0ea3f7ae47f4b35741deaf072d8333298dc177ec9c689d062efe0d564db75e65f"} 09:01:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:12 INFO - Copying logs to upload dir... 09:01:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.937763 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-11 09:01:12.411900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 09:01:12.415440) ========= 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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 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-Beta/sha512/76a94a6db00f6fead82ed60c92e7491af61b0fb18315c5e2a5781cad7e2e301c3243c015ced8d2574e11b430873a52fbcd290048c2b2c4e0b09d417848511b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6fb90d58e3aeebb15ca2871db3f111fd32ec0c4e935ab0ce741b772dfa19066c166fcd230c502aa62ae9fe7aba42793da25a45d7782202bb8c2ea445b594446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b435891eeeda2b6b76366349f12bf90386f0cb03bc0fec6d9297cf047137fb0ea3f7ae47f4b35741deaf072d8333298dc177ec9c689d062efe0d564db75e65f"} build_url:https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/KIMay86ETYmpvn6ORv9Ycg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76a94a6db00f6fead82ed60c92e7491af61b0fb18315c5e2a5781cad7e2e301c3243c015ced8d2574e11b430873a52fbcd290048c2b2c4e0b09d417848511b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6fb90d58e3aeebb15ca2871db3f111fd32ec0c4e935ab0ce741b772dfa19066c166fcd230c502aa62ae9fe7aba42793da25a45d7782202bb8c2ea445b594446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b435891eeeda2b6b76366349f12bf90386f0cb03bc0fec6d9297cf047137fb0ea3f7ae47f4b35741deaf072d8333298dc177ec9c689d062efe0d564db75e65f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 09:01:12.440355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:01:12.440903) ========= 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=eca2ab57546de7b41f256b19000001ef-1484152829.858509-1975593223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:01:12.524060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 09:01:12.524405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 09:01:12.524727) ========= ========= Total master_lag: 0.43 =========