builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1479995341.02 results: success (0) buildid: 20161124030537 builduid: 7c5c5ccf5f7440f780c04e55cf2697de revision: 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.022213) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.022654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.022941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.037715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.038013) ========= 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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 05:49:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-11-24 05:49:01 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.174259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.174538) ========= 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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018074 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:01.224750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 05:49:01.225107) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa --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 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa --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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 05:49:01,298 truncating revision to first 12 chars 2016-11-24 05:49:01,298 Setting DEBUG logging. 2016-11-24 05:49:01,298 attempt 1/10 2016-11-24 05:49:01,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6f0b8c9b39ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 05:49:03,091 unpacking tar archive at: mozilla-beta-6f0b8c9b39ac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.128773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 05:49:03.367070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:03.367366) ========= script_repo_revision: 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:03.367800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:03.368080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 05:49:03.376100) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-24 05:49:03.376393) ========= /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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:03 INFO - MultiFileLogger online at 20161124 05:49:03 in /builds/slave/test 05:49:03 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 05:49:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:03 INFO - {'append_to_log': False, 05:49:03 INFO - 'base_work_dir': '/builds/slave/test', 05:49:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:49:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:03 INFO - 'branch': 'Mozilla-Beta', 05:49:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:03 INFO - 'config_files': ('talos/linux_config.py',), 05:49:03 INFO - 'default_actions': ('clobber', 05:49:03 INFO - 'read-buildbot-config', 05:49:03 INFO - 'download-and-extract', 05:49:03 INFO - 'populate-webroot', 05:49:03 INFO - 'create-virtualenv', 05:49:03 INFO - 'install', 05:49:03 INFO - 'run-tests'), 05:49:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:03 INFO - 'download_minidump_stackwalk': True, 05:49:03 INFO - 'download_symbols': 'ondemand', 05:49:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:03 INFO - 'installer_path': 'installer.exe', 05:49:03 INFO - 'log_level': 'info', 05:49:03 INFO - 'log_name': 'talos', 05:49:03 INFO - 'log_to_console': True, 05:49:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:03 INFO - 'opt_config_files': (), 05:49:03 INFO - 'pip_index': False, 05:49:03 INFO - 'sps_profile': False, 05:49:03 INFO - 'sps_profile_interval': 0, 05:49:03 INFO - 'suite': 'dromaeojs', 05:49:03 INFO - 'system_bits': '32', 05:49:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:03 INFO - 'title': 'talos-linux64-ix-027', 05:49:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:03 INFO - 'use_talos_json': True, 05:49:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:03 INFO - 'work_dir': 'build'} 05:49:03 INFO - [mozharness: 2016-11-24 13:49:03.544402Z] Running clobber step. 05:49:03 INFO - Running pre-action listener: _resource_record_pre_action 05:49:03 INFO - Running main action method: clobber 05:49:03 INFO - rmtree: /builds/slave/test/build 05:49:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:03 INFO - Running post-action listener: _resource_record_post_action 05:49:03 INFO - [mozharness: 2016-11-24 13:49:03.991455Z] Finished clobber step (success) 05:49:03 INFO - [mozharness: 2016-11-24 13:49:03.991558Z] Running read-buildbot-config step. 05:49:03 INFO - Running pre-action listener: _resource_record_pre_action 05:49:03 INFO - Running main action method: read_buildbot_config 05:49:03 INFO - Using buildbot properties: 05:49:03 INFO - { 05:49:03 INFO - "project": "", 05:49:03 INFO - "product": "firefox", 05:49:03 INFO - "script_repo_revision": "production", 05:49:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:49:03 INFO - "repository": "", 05:49:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:49:03 INFO - "buildid": "20161124030537", 05:49:03 INFO - "pgo_build": "True", 05:49:03 INFO - "basedir": "/builds/slave/test", 05:49:03 INFO - "buildnumber": 28, 05:49:03 INFO - "slavename": "talos-linux64-ix-027", 05:49:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:49:03 INFO - "platform": "ubuntu64_hw", 05:49:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:49:03 INFO - "branch": "mozilla-beta", 05:49:03 INFO - "repo_path": "releases/mozilla-beta", 05:49:03 INFO - "revision": "6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa", 05:49:03 INFO - "stage_platform": "linux64-pgo", 05:49:03 INFO - "builduid": "7c5c5ccf5f7440f780c04e55cf2697de", 05:49:03 INFO - "slavebuilddir": "test" 05:49:03 INFO - } 05:49:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 05:49:03 INFO - Running post-action listener: _resource_record_post_action 05:49:03 INFO - [mozharness: 2016-11-24 13:49:03.993995Z] Finished read-buildbot-config step (success) 05:49:03 INFO - [mozharness: 2016-11-24 13:49:03.994084Z] Running download-and-extract step. 05:49:03 INFO - Running pre-action listener: _resource_record_pre_action 05:49:03 INFO - Running main action method: download_and_extract 05:49:03 INFO - mkdir: /builds/slave/test/build/tests 05:49: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')]} 05:49:03 INFO - trying https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:49:03 INFO - Downloading https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/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 05:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/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 05:49:04 INFO - Downloaded 1327 bytes. 05:49:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:49:04 INFO - Using the following test package requirements: 05:49:04 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:49:04 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:04 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 05:49:04 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'jsshell-linux-x86_64.zip'], 05:49:04 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:04 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:49:04 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 05:49:04 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 05:49:04 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:04 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:04 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:49:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:04 INFO - Fetch https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:49:05 INFO - Expected file size: 21963587 05:49:09 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 05:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:49:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:09 INFO - Fetch https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:49:09 INFO - Expected file size: 21963587 05:49:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 05:49:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:14 INFO - Fetch https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 05:49:15 INFO - Expected file size: 14414089 05:49: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')]} 05:49:16 INFO - trying https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:49:16 INFO - Downloading https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/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 05:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/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 05:49:20 INFO - Downloaded 56984778 bytes. 05:49:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:49:20 INFO - mkdir: /builds/slave/test/properties 05:49:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:20 INFO - Contents: 05:49:20 INFO - build_url:https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:49:20 INFO - Running post-action listener: _resource_record_post_action 05:49:20 INFO - Running post-action listener: set_extra_try_arguments 05:49:20 INFO - [mozharness: 2016-11-24 13:49:20.922088Z] Finished download-and-extract step (success) 05:49:20 INFO - [mozharness: 2016-11-24 13:49:20.922315Z] Running populate-webroot step. 05:49:20 INFO - Running pre-action listener: _resource_record_pre_action 05:49:20 INFO - Running main action method: populate_webroot 05:49:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:20 INFO - '--tppagecycles', 05:49:20 INFO - '7'], 05:49:20 INFO - 'tests': ['tsvgm']}}, 05:49:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['damp', 'tps']}, 05:49:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'tests': ['damp', 'tps']}, 05:49:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['dromaeo_dom']}, 05:49:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['basic_compositor_video']}, 05:49:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['a11yr', 05:49:20 INFO - 'ts_paint', 05:49:20 INFO - 'tpaint', 05:49:20 INFO - 'sessionrestore', 05:49:20 INFO - 'sessionrestore_no_auto_restore', 05:49:20 INFO - 'tabpaint']}, 05:49:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['tsvgx', 05:49:20 INFO - 'tsvgr_opacity', 05:49:20 INFO - 'tart', 05:49:20 INFO - 'tscrollx', 05:49:20 INFO - 'cart']}, 05:49:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:20 INFO - 'tsvgr_opacity', 05:49:20 INFO - 'tart', 05:49:20 INFO - 'tscrollx', 05:49:20 INFO - 'cart']}, 05:49:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'talos_options': ['--disable-e10s'], 05:49:20 INFO - 'tests': ['tp5o']}, 05:49:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'tests': ['tp5o']}, 05:49:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'talos_options': ['--disable-e10s', 05:49:20 INFO - '--xperf_path', 05:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:20 INFO - 'tests': ['tp5n']}, 05:49:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:20 INFO - 'talos_options': ['--xperf_path', 05:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:20 INFO - 'tests': ['tp5n']}}, 05:49:20 INFO - 'talos.zip': {'path': '', 05:49:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:20 INFO - Running post-action listener: _resource_record_post_action 05:49:20 INFO - [mozharness: 2016-11-24 13:49:20.940205Z] Finished populate-webroot step (success) 05:49:20 INFO - [mozharness: 2016-11-24 13:49:20.940298Z] Running create-virtualenv step. 05:49:20 INFO - Running pre-action listener: _resource_record_pre_action 05:49:20 INFO - Running main action method: create_virtualenv 05:49:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:20 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 05:49:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:21 INFO - Using real prefix '/usr' 05:49:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:23 INFO - Installing pip.................done. 05:49:23 INFO - Return code: 0 05:49:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:23 INFO - Using env: {'DISPLAY': ':0', 05:49:23 INFO - 'HOME': '/home/cltbld', 05:49:23 INFO - 'LANG': 'en_US.UTF-8', 05:49:23 INFO - 'LANGUAGE': 'en_US:en', 05:49:23 INFO - 'LOGNAME': 'cltbld', 05:49:23 INFO - 'MAIL': '/var/mail/cltbld', 05:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:23 INFO - 'MOZ_NO_REMOTE': '1', 05:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:23 INFO - 'NO_EM_RESTART': '1', 05:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:23 INFO - 'PWD': '/builds/slave/test', 05:49:23 INFO - 'SHELL': '/bin/bash', 05:49:23 INFO - 'SHLVL': '1', 05:49:23 INFO - 'TERM': 'linux', 05:49:23 INFO - 'TMOUT': '86400', 05:49:23 INFO - 'USER': 'cltbld', 05:49:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:23 INFO - '_': '/tools/buildbot/bin/python'} 05:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:23 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 05:49:23 INFO - Cleaning up... 05:49:23 INFO - Return code: 0 05:49:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:23 INFO - Using env: {'DISPLAY': ':0', 05:49:23 INFO - 'HOME': '/home/cltbld', 05:49:23 INFO - 'LANG': 'en_US.UTF-8', 05:49:23 INFO - 'LANGUAGE': 'en_US:en', 05:49:23 INFO - 'LOGNAME': 'cltbld', 05:49:23 INFO - 'MAIL': '/var/mail/cltbld', 05:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:23 INFO - 'MOZ_NO_REMOTE': '1', 05:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:23 INFO - 'NO_EM_RESTART': '1', 05:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:23 INFO - 'PWD': '/builds/slave/test', 05:49:23 INFO - 'SHELL': '/bin/bash', 05:49:23 INFO - 'SHLVL': '1', 05:49:23 INFO - 'TERM': 'linux', 05:49:23 INFO - 'TMOUT': '86400', 05:49:23 INFO - 'USER': 'cltbld', 05:49:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:23 INFO - '_': '/tools/buildbot/bin/python'} 05:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:23 INFO - Downloading/unpacking psutil>=3.1.1 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:25 INFO - Installing collected packages: psutil 05:49:25 INFO - Running setup.py install for psutil 05:49:26 INFO - building 'psutil._psutil_linux' extension 05:49:26 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 05:49:26 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 05:49:26 INFO - building 'psutil._psutil_posix' extension 05:49:26 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 05:49:26 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 05:49:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:26 INFO - Successfully installed psutil 05:49:26 INFO - Cleaning up... 05:49:26 INFO - Return code: 0 05:49:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:26 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:26 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 05:49:26 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 05:49:26 INFO - Using env: {'DISPLAY': ':0', 05:49:26 INFO - 'HOME': '/home/cltbld', 05:49:26 INFO - 'LANG': 'en_US.UTF-8', 05:49:26 INFO - 'LANGUAGE': 'en_US:en', 05:49:26 INFO - 'LOGNAME': 'cltbld', 05:49:26 INFO - 'MAIL': '/var/mail/cltbld', 05:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:26 INFO - 'MOZ_NO_REMOTE': '1', 05:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:26 INFO - 'NO_EM_RESTART': '1', 05:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:26 INFO - 'PWD': '/builds/slave/test', 05:49:26 INFO - 'SHELL': '/bin/bash', 05:49:26 INFO - 'SHLVL': '1', 05:49:26 INFO - 'TERM': 'linux', 05:49:26 INFO - 'TMOUT': '86400', 05:49:26 INFO - 'USER': 'cltbld', 05:49:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:26 INFO - '_': '/tools/buildbot/bin/python'} 05:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:26 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 05:49:26 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 05:49:26 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 05:49:26 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 05:49:26 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 05:49:26 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 05:49:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:28 INFO - Installing collected packages: mozsystemmonitor 05:49:28 INFO - Running setup.py install for mozsystemmonitor 05:49:28 INFO - Successfully installed mozsystemmonitor 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:49:28 INFO - Using env: {'DISPLAY': ':0', 05:49:28 INFO - 'HOME': '/home/cltbld', 05:49:28 INFO - 'LANG': 'en_US.UTF-8', 05:49:28 INFO - 'LANGUAGE': 'en_US:en', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MAIL': '/var/mail/cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SHLVL': '1', 05:49:28 INFO - 'TERM': 'linux', 05:49:28 INFO - 'TMOUT': '86400', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - '_': '/tools/buildbot/bin/python'} 05:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:31 INFO - warning: no files found matching '*.txt' 05:49:31 INFO - no previously-included directories found matching 'build' 05:49:31 INFO - no previously-included directories found matching 'dist' 05:49:31 INFO - no previously-included directories found matching '.git*' 05:49:31 INFO - Installing collected packages: jsonschema, functools32 05:49:31 INFO - Running setup.py install for functools32 05:49:31 INFO - warning: no files found matching '*.txt' 05:49:31 INFO - no previously-included directories found matching 'build' 05:49:31 INFO - no previously-included directories found matching 'dist' 05:49:31 INFO - no previously-included directories found matching '.git*' 05:49:31 INFO - Successfully installed jsonschema functools32 05:49:31 INFO - Cleaning up... 05:49:31 INFO - Return code: 0 05:49:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:31 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:31 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 05:49:31 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 05:49:31 INFO - Using env: {'DISPLAY': ':0', 05:49:31 INFO - 'HOME': '/home/cltbld', 05:49:31 INFO - 'LANG': 'en_US.UTF-8', 05:49:31 INFO - 'LANGUAGE': 'en_US:en', 05:49:31 INFO - 'LOGNAME': 'cltbld', 05:49:31 INFO - 'MAIL': '/var/mail/cltbld', 05:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:31 INFO - 'MOZ_NO_REMOTE': '1', 05:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:31 INFO - 'NO_EM_RESTART': '1', 05:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:31 INFO - 'PWD': '/builds/slave/test', 05:49:31 INFO - 'SHELL': '/bin/bash', 05:49:31 INFO - 'SHLVL': '1', 05:49:31 INFO - 'TERM': 'linux', 05:49:31 INFO - 'TMOUT': '86400', 05:49:31 INFO - 'USER': 'cltbld', 05:49:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:31 INFO - '_': '/tools/buildbot/bin/python'} 05:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:49:31 INFO - Cleaning up... 05:49:31 INFO - Return code: 0 05:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:31 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:31 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 05:49:31 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 05:49:31 INFO - Using env: {'DISPLAY': ':0', 05:49:31 INFO - 'HOME': '/home/cltbld', 05:49:31 INFO - 'LANG': 'en_US.UTF-8', 05:49:31 INFO - 'LANGUAGE': 'en_US:en', 05:49:31 INFO - 'LOGNAME': 'cltbld', 05:49:31 INFO - 'MAIL': '/var/mail/cltbld', 05:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:31 INFO - 'MOZ_NO_REMOTE': '1', 05:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:31 INFO - 'NO_EM_RESTART': '1', 05:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:31 INFO - 'PWD': '/builds/slave/test', 05:49:31 INFO - 'SHELL': '/bin/bash', 05:49:31 INFO - 'SHLVL': '1', 05:49:31 INFO - 'TERM': 'linux', 05:49:31 INFO - 'TMOUT': '86400', 05:49:31 INFO - 'USER': 'cltbld', 05:49:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:31 INFO - '_': '/tools/buildbot/bin/python'} 05:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 INFO - Downloading docopt-0.6.1.tar.gz 05:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:34 INFO - Running setup.py install for blobuploader 05:49:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:34 INFO - Running setup.py install for requests 05:49:35 INFO - Running setup.py install for docopt 05:49:35 INFO - Successfully installed blobuploader requests docopt 05:49:35 INFO - Cleaning up... 05:49:35 INFO - Return code: 0 05:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:35 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 05:49:35 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 05:49:35 INFO - Using env: {'DISPLAY': ':0', 05:49:35 INFO - 'HOME': '/home/cltbld', 05:49:35 INFO - 'LANG': 'en_US.UTF-8', 05:49:35 INFO - 'LANGUAGE': 'en_US:en', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MAIL': '/var/mail/cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SHLVL': '1', 05:49:35 INFO - 'TERM': 'linux', 05:49:35 INFO - 'TMOUT': '86400', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - '_': '/tools/buildbot/bin/python'} 05:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:35 INFO - Running setup.py (path:/tmp/pip-XDkZqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:35 INFO - Running setup.py (path:/tmp/pip-JN1CeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:35 INFO - Running setup.py (path:/tmp/pip-4yQ76H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:35 INFO - Running setup.py (path:/tmp/pip-LQOiJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:35 INFO - Running setup.py (path:/tmp/pip-dbmXWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:35 INFO - Running setup.py (path:/tmp/pip-7tX33d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:35 INFO - Running setup.py (path:/tmp/pip-vHguXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:35 INFO - Running setup.py (path:/tmp/pip-eN8su_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:36 INFO - Running setup.py (path:/tmp/pip-7jwWer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:36 INFO - Running setup.py (path:/tmp/pip-wwZQin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:36 INFO - Running setup.py (path:/tmp/pip-gmQupy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:36 INFO - Running setup.py (path:/tmp/pip-_rsDHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:36 INFO - Running setup.py (path:/tmp/pip-MO4GTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:36 INFO - Running setup.py (path:/tmp/pip-FlQo_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:36 INFO - Running setup.py (path:/tmp/pip-um0k7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:36 INFO - Running setup.py (path:/tmp/pip-X2QAnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:36 INFO - Running setup.py (path:/tmp/pip-zEU7zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:36 INFO - Running setup.py install for manifestparser 05:49:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for mozcrash 05:49:36 INFO - Running setup.py install for mozdebug 05:49:36 INFO - Running setup.py install for mozdevice 05:49:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for mozfile 05:49:37 INFO - Running setup.py install for mozhttpd 05:49:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for mozinfo 05:49:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for mozInstall 05:49:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for mozleak 05:49:37 INFO - Running setup.py install for mozlog 05:49:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for moznetwork 05:49:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:37 INFO - Running setup.py install for mozprocess 05:49:37 INFO - Running setup.py install for mozprofile 05:49:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:38 INFO - Running setup.py install for mozrunner 05:49:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:38 INFO - Running setup.py install for mozscreenshot 05:49:38 INFO - Running setup.py install for moztest 05:49:38 INFO - Running setup.py install for mozversion 05:49:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:38 INFO - Cleaning up... 05:49:38 INFO - Return code: 0 05:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:38 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 05:49:38 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 05:49:38 INFO - Using env: {'DISPLAY': ':0', 05:49:38 INFO - 'HOME': '/home/cltbld', 05:49:38 INFO - 'LANG': 'en_US.UTF-8', 05:49:38 INFO - 'LANGUAGE': 'en_US:en', 05:49:38 INFO - 'LOGNAME': 'cltbld', 05:49:38 INFO - 'MAIL': '/var/mail/cltbld', 05:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:38 INFO - 'MOZ_NO_REMOTE': '1', 05:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:38 INFO - 'NO_EM_RESTART': '1', 05:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:38 INFO - 'PWD': '/builds/slave/test', 05:49:38 INFO - 'SHELL': '/bin/bash', 05:49:38 INFO - 'SHLVL': '1', 05:49:38 INFO - 'TERM': 'linux', 05:49:38 INFO - 'TMOUT': '86400', 05:49:38 INFO - 'USER': 'cltbld', 05:49:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:38 INFO - '_': '/tools/buildbot/bin/python'} 05:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:38 INFO - Running setup.py (path:/tmp/pip-Ye1ka7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:38 INFO - Running setup.py (path:/tmp/pip-lA7rjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:38 INFO - Running setup.py (path:/tmp/pip-Heq8I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:38 INFO - Running setup.py (path:/tmp/pip-NVj34M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:39 INFO - Running setup.py (path:/tmp/pip-HkmW5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:39 INFO - Running setup.py (path:/tmp/pip-WvVliB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:39 INFO - Running setup.py (path:/tmp/pip-5tlBWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:39 INFO - Running setup.py (path:/tmp/pip-axW7Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:39 INFO - Running setup.py (path:/tmp/pip-V1CHa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:39 INFO - Running setup.py (path:/tmp/pip-V4qIiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:39 INFO - Running setup.py (path:/tmp/pip-0lCZDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:39 INFO - Running setup.py (path:/tmp/pip-KuGyyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:39 INFO - Running setup.py (path:/tmp/pip-JTZCiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:39 INFO - Running setup.py (path:/tmp/pip-s89CV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:39 INFO - Running setup.py (path:/tmp/pip-LaBdDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:39 INFO - Running setup.py (path:/tmp/pip-iPJgZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:39 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)) 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:39 INFO - Running setup.py (path:/tmp/pip-Vyj34X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:39 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)) 05:49:39 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)) 05:49:39 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)) 05:49:39 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)) 05:49:39 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)) 05:49:39 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)) 05:49:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:41 INFO - Downloading blessings-1.6.tar.gz 05:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:42 INFO - Installing collected packages: blessings 05:49:42 INFO - Running setup.py install for blessings 05:49:42 INFO - Successfully installed blessings 05:49:42 INFO - Cleaning up... 05:49:42 INFO - Return code: 0 05:49:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:42 INFO - Reading from file tmpfile_stdout 05:49:42 INFO - Current package versions: 05:49:42 INFO - argparse == 1.2.1 05:49:42 INFO - blessings == 1.6 05:49:42 INFO - blobuploader == 1.2.4 05:49:42 INFO - docopt == 0.6.1 05:49:42 INFO - functools32 == 3.2.3-2 05:49:42 INFO - jsonschema == 2.5.1 05:49:42 INFO - manifestparser == 1.1 05:49:42 INFO - mozInstall == 1.12 05:49:42 INFO - mozcrash == 0.17 05:49:42 INFO - mozdebug == 0.1 05:49:42 INFO - mozdevice == 0.48 05:49:42 INFO - mozfile == 1.2 05:49:42 INFO - mozhttpd == 0.7 05:49:42 INFO - mozinfo == 0.9 05:49:42 INFO - mozleak == 0.1 05:49:42 INFO - mozlog == 3.4 05:49:42 INFO - moznetwork == 0.27 05:49:42 INFO - mozprocess == 0.23 05:49:42 INFO - mozprofile == 0.28 05:49:42 INFO - mozrunner == 6.12 05:49:42 INFO - mozscreenshot == 0.1 05:49:42 INFO - mozsystemmonitor == 0.3 05:49:42 INFO - moztest == 0.7 05:49:42 INFO - mozversion == 1.4 05:49:42 INFO - psutil == 3.1.1 05:49:42 INFO - requests == 1.2.3 05:49:42 INFO - wsgiref == 0.1.2 05:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:42 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')]} 05:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:42 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')]} 05:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:42 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:42 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 05:49:42 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 05:49:42 INFO - Using env: {'DISPLAY': ':0', 05:49:42 INFO - 'HOME': '/home/cltbld', 05:49:42 INFO - 'LANG': 'en_US.UTF-8', 05:49:42 INFO - 'LANGUAGE': 'en_US:en', 05:49:42 INFO - 'LOGNAME': 'cltbld', 05:49:42 INFO - 'MAIL': '/var/mail/cltbld', 05:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:42 INFO - 'MOZ_NO_REMOTE': '1', 05:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:42 INFO - 'NO_EM_RESTART': '1', 05:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:42 INFO - 'PWD': '/builds/slave/test', 05:49:42 INFO - 'SHELL': '/bin/bash', 05:49:42 INFO - 'SHLVL': '1', 05:49:42 INFO - 'TERM': 'linux', 05:49:42 INFO - 'TMOUT': '86400', 05:49:42 INFO - 'USER': 'cltbld', 05:49:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:42 INFO - '_': '/tools/buildbot/bin/python'} 05:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 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)) 05:49:42 INFO - Cleaning up... 05:49:42 INFO - Return code: 0 05:49:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:42 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')]} 05:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:42 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')]} 05:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:42 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 0x7fc7ffcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', '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 05:49:42 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 05:49:42 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 05:49:42 INFO - Using env: {'DISPLAY': ':0', 05:49:42 INFO - 'HOME': '/home/cltbld', 05:49:42 INFO - 'LANG': 'en_US.UTF-8', 05:49:42 INFO - 'LANGUAGE': 'en_US:en', 05:49:42 INFO - 'LOGNAME': 'cltbld', 05:49:42 INFO - 'MAIL': '/var/mail/cltbld', 05:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:42 INFO - 'MOZ_NO_REMOTE': '1', 05:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:42 INFO - 'NO_EM_RESTART': '1', 05:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:42 INFO - 'PWD': '/builds/slave/test', 05:49:42 INFO - 'SHELL': '/bin/bash', 05:49:42 INFO - 'SHLVL': '1', 05:49:42 INFO - 'TERM': 'linux', 05:49:42 INFO - 'TMOUT': '86400', 05:49:42 INFO - 'USER': 'cltbld', 05:49:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:42 INFO - '_': '/tools/buildbot/bin/python'} 05:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:42 INFO - Cleaning up... 05:49:42 INFO - Return code: 0 05:49:42 INFO - Running post-action listener: _resource_record_post_action 05:49:42 INFO - Running post-action listener: _start_resource_monitoring 05:49:42 INFO - Starting resource monitoring. 05:49:42 INFO - [mozharness: 2016-11-24 13:49:42.871249Z] Finished create-virtualenv step (success) 05:49:42 INFO - [mozharness: 2016-11-24 13:49:42.871694Z] Running install step. 05:49:42 INFO - Running pre-action listener: _resource_record_pre_action 05:49:42 INFO - Running main action method: install 05:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:43 INFO - Reading from file tmpfile_stdout 05:49:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:43 INFO - Reading from file tmpfile_stdout 05:49:43 INFO - Output received: 05:49:43 INFO - Usage: mozinstall [options] installer 05:49:43 INFO - Options: 05:49:43 INFO - -h, --help show this help message and exit 05:49:43 INFO - -d DEST, --destination=DEST 05:49:43 INFO - Directory to install application into. [default: 05:49:43 INFO - "/builds/slave/test"] 05:49:43 INFO - --app=APP Application being installed. [default: firefox] 05:49:43 INFO - mkdir: /builds/slave/test/build/application 05:49:43 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'] 05:49:43 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 05:49:56 INFO - Reading from file tmpfile_stdout 05:49:56 INFO - Output received: 05:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:56 INFO - Running post-action listener: _resource_record_post_action 05:49:56 INFO - [mozharness: 2016-11-24 13:49:56.673513Z] Finished install step (success) 05:49:56 INFO - [mozharness: 2016-11-24 13:49:56.673765Z] Running run-tests step. 05:49:56 INFO - Running pre-action listener: _resource_record_pre_action 05:49:56 INFO - Running main action method: run_tests 05:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:56 INFO - Python 2.7.3 05:49:56 INFO - Return code: 0 05:49:56 INFO - grabbing minidump binary from tooltool 05:49:56 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')]} 05:49:56 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 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:56 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 05:49:56 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 05:49:56 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 05:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:56 INFO - Return code: 0 05:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:56 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/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:49:56 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/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 05:49:56 INFO - Using env: {'DISPLAY': ':0', 05:49:56 INFO - 'HOME': '/home/cltbld', 05:49:56 INFO - 'LANG': 'en_US.UTF-8', 05:49:56 INFO - 'LANGUAGE': 'en_US:en', 05:49:56 INFO - 'LOGNAME': 'cltbld', 05:49:56 INFO - 'MAIL': '/var/mail/cltbld', 05:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:56 INFO - 'MOZ_NO_REMOTE': '1', 05:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:56 INFO - 'NO_EM_RESTART': '1', 05:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:56 INFO - 'PWD': '/builds/slave/test', 05:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:56 INFO - 'SHELL': '/bin/bash', 05:49:56 INFO - 'SHLVL': '1', 05:49:56 INFO - 'TERM': 'linux', 05:49:56 INFO - 'TMOUT': '86400', 05:49:56 INFO - 'USER': 'cltbld', 05:49:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433', 05:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:56 INFO - '_': '/tools/buildbot/bin/python'} 05:49:56 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/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:49:56 INFO - mozversion application_buildid: 20161124030537 05:49:56 INFO - mozversion application_changeset: 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa 05:49:56 INFO - mozversion application_display_name: Firefox 05:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:56 INFO - mozversion application_name: Firefox 05:49:56 INFO - mozversion application_remotingname: firefox 05:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:49:56 INFO - mozversion application_vendor: Mozilla 05:49:56 INFO - mozversion application_version: 51.0 05:49:56 INFO - mozversion platform_buildid: 20161124030537 05:49:56 INFO - mozversion platform_changeset: 6f0b8c9b39acb34c6aa58d2cb00bbc90b405feaa 05:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:49:56 INFO - mozversion platform_version: 51.0 05:49:56 INFO - using testdate: 1479995396 05:49:56 INFO - actual date: 1479995396 05:49:56 INFO - starting webserver on 'localhost:49779' 05:49:56 INFO - SUITE-START | Running 2 tests 05:49:56 INFO - TEST-START | dromaeo_css 05:49:56 INFO - operating with platform_type : linux_ 05:49:56 INFO - Initialising browser for dromaeo_css test... 05:49:57 INFO - TEST-INFO | started process 8078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp70nr4s/profile http://localhost:49779/getInfo.html) 05:50:00 INFO - PROCESS | 8078 | __metrics Screen width/height:1600/1200 05:50:00 INFO - PROCESS | 8078 | colorDepth:24 05:50:00 INFO - PROCESS | 8078 | Browser inner width/height: 1024/697 05:50:00 INFO - PROCESS | 8078 | __metrics 05:50:01 INFO - PROCESS | 8078 | 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" 05:50:01 INFO - PROCESS | 8078 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:01 INFO - PROCESS | 8078 | console.error: PushService: 05:50:01 INFO - PROCESS | 8078 | stateChangeProcessEnqueue: Error transitioning state 05:50:01 INFO - PROCESS | 8078 | UnknownError 05:50:02 INFO - TEST-INFO | 8078: exit 0 05:50:02 INFO - Browser initialized. 05:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:02 INFO - TEST-INFO | started process 8167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp70nr4s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:14 INFO - PROCESS | 8167 | RSS: Main: 142221312 05:50:14 INFO - PROCESS | 8167 | 05:51:05 INFO - PROCESS | 8167 | 1479995465453 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] 05:53:14 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49779/tests/dromaeo/cssquery-ext.html) 05:53:15 INFO - PROCESS | 8167 | RSS: Main: 240648192 05:53:15 INFO - PROCESS | 8167 | 05:56:17 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-ext.html (next: http://localhost:49779/tests/dromaeo/cssquery-jquery.html) 05:56:18 INFO - PROCESS | 8167 | RSS: Main: 233701376 05:56:18 INFO - PROCESS | 8167 | 05:59:20 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49779/tests/dromaeo/cssquery-mootools.html) 05:59:20 INFO - PROCESS | 8167 | RSS: Main: 215322624 05:59:20 INFO - PROCESS | 8167 | 06:02:22 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49779/tests/dromaeo/cssquery-prototype.html) 06:02:23 INFO - PROCESS | 8167 | RSS: Main: 219799552 06:02:23 INFO - PROCESS | 8167 | 06:05:25 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49779/tests/dromaeo/cssquery-yui.html) 06:05:26 INFO - PROCESS | 8167 | RSS: Main: 176803840 06:05:26 INFO - PROCESS | 8167 | 06:08:28 INFO - PROCESS | 8167 | Cycle 1(1): loaded http://localhost:49779/tests/dromaeo/cssquery-yui.html (next: http://localhost:49779/tests/dromaeo/cssquery-dojo.html) 06:08:29 INFO - PROCESS | 8167 | RSS: Main: 265146368 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | __start_tp_report 06:08:29 INFO - PROCESS | 8167 | _x_x_mozilla_page_load 06:08:29 INFO - PROCESS | 8167 | _x_x_mozilla_page_load_details 06:08:29 INFO - PROCESS | 8167 | |i|pagename|runs| 06:08:29 INFO - PROCESS | 8167 | |0;dojo.html;3151.1019359482543;3197.4884018557036;3208.1017315151757;3211.7109460148595;3252.170696472399;5690.260266165398;5760.913586296198;5769.740361683724;5789.218455508505;5795.391483894188;5629.465200805927;5667.263255776754;5686.459786320293;5693.686847223401;5694.658320500773;5129.281900533928;5173.6119791015635;5178.14560597501;5178.637495375326;5239.3712754469325;5137.101007323722;5250.7374631268285;5266.81566145185;5268.5521730652945;5291.5766738661005;5078.339815823938;5120.769565369549;5206.479352064782;5238.345206849144;5255.106631872572;5106.617003724736;5124.282600435923;5127.282180494733;5206.583473322125;5212.1921102228835;5102.1071312520535;5131.076406246874;5223.582113430916;5233.633645644806;5263.973680131613;5427.48438898304;5473.01485732568;5512.862178445531;5567.220589117527;5574.470425309589;6001.639901605918;6016.578839481238;6101.328853826076;6105.267367915834;6109.816705498843;6158.107074474221;6160.383961603849;6160.691965401712;6172.321044685126;6173.567850250484;5566.387697353288;5585.385607583163;5631.662100273956;5644.209810626516;5644.802431914945;6220.315765265817;6243.219597550306;6260.780872669435;6261.9373806262265;6268.49852011838;5975.163477113208;5994.280686317583;5996.576521726119;5999.430054144849;6024.939750602525;5774.2782152230975;5830.679312637761;5903.852403689856;5966.701664916737;6076.939230607637;5982.042873140364;5987.820365389045;5988.700564971734;6024.969875150597;6029.547783916224;5948.672822994777;5962.582619216613;6005.429484198994;6007.969960150172;6036.728347224385;4558.2251017327135;4572.817087316536;4620.468646105741;4634.72191668501;4634.884127896762;4104.56902025283;4106.548279689232;4111.650509706708;4158.147579746144;4171.124063946544;5786.826395208151;5795.304563452329;5795.855103622359;5798.536117110621;5828.6502809831545;5943.643381397043;6011.5190784737115;6060.2424696912885;6090.33006369299;6093.66484843329;5641.12562552805;5665.206871038058;5677.829665110054;5750.338711048283;5782.306123265151;5181.06740786662;5202.661826981234;5210.114280572312;5218.217267409843;5219.530242278213;6081.148639190517;6185;6210.875782484415;6220.471259942865;6224.906626400608;6035.456808887221;6078.331383547895;6090.756369745161;6160.476359509492;6161.045038019114;6319.873602528016;6325;6329.145565348619;6331.96834015827;6349.079383489276;5849.064149736022;6011.158437818622;6017.097435384728;6019;6020.608660437058;6000.249968753906;6073.089036644538;6079.604825686316;6093.421124993119;6207.565470417027;6004.669743164168;6045.335013148638;6064.363241859718;6066.090086487062;6068.120122582112;6051.425114614105;6061.818145455643;6062.272527296753;6063.72713227897;6066.241719785027;5828.446297601721;5904.852378690567;5905.704714764331;5957.523398128053;5964.284285885721;6052.636841789506;6072.423119803611;6073.240844894388;6086.847828804315;6095.725692343766;5917.142014407973;5953.642781433128;5971;5983.042713166046;5983.102534619842 06:08:29 INFO - PROCESS | 8167 | |1;ext.html;597.6264834478451;611.6421893192482;633.154738424204;635.1774452084552;648.7048392981194;33574.664253357456;46348.3047754284;47198.52801471984;47303.29045064327;47335.526644733545;48108.59457027143;48347.51652483474;48782.51217487824;48811;48846.51153488473;8535.189157030103;9276.211522020636;9439.292053096011;9480.573374198178;9484.66803661872;8378.455400398985;11073.114150867912;11293.774124517504;11309.886901131007;11689;11446.084313254962;11497.195196336259;11506.194566380356;11522.135839812006;11523.769524609503;11162.832557511643;11212.215144939817;11250.774984500345;11254.887451125547;11266.380349080797;10902.182336324728;10954.39750813705;10969.341839489656;10978.451077446176;10980.121590272758;45008;45234.77382613066;45245;45260.547394525966;45367.54632453666;3737.177820879402;3743.12036671382;4401.361802538646;4421.535738747418;4456.665750068725;34293.657063429295;34404.82797586021;34689.30621387583;34693;35158.29683406318;4733.100710864925;4755.667103302771;4767.094252092092;4840.249761287007;4883.8290659826735;355763.221183895;358113;358299;359032;359346;65239;65254;65649.67175164189;65683.34316656868;65770.67114664492;40801;41881;42067.36898946518;68813;69019.3098069023;18291.26834926588;18341.082945852922;18415.90792046031;18416.631667366844;18468.722969155475;13150.145240559334;13595;13692.246926419142;13746.65633359174;13908.652283692989;20383.79616203819;20941.16235350569;21140;21222.151113955577;21353.46616334573;7341.853162936818;7442.553446793209;7587;7642.968199293025;7811.4922530035365;994.7761753605381;1001.1590264178126;1053.173258991703;1102.7518808268076;1157.3056166300153;33566.83216583901;33628.49557256643;34323.656763432045;34482.48276275858;35061.47407788885;1086.342762628614;1119.8600174978128;1129.667480931256;1189.5301355964518;1232.7411243638937;18203.452706520093;18407.72388414175;18461.630767384846;18494.722579161324;18508.259669613333;581313;584780;585858;586601;588325;63555.36444635587;64241.35758642447;64244.357556423834;64284.67857660682;64315.67842160759;1320.6896379350844;1358.334416136106;1409.0629731228619;1418.2554159066572;1448.4351103069812;30740.846295769272;34836.65163348334;35416.114597135274;35752.463713043806;35760;55457;55641.7217913924;55873.161902572305;56119.71940140273;56445.71777141252;407157;407515;408219;408648;409055;28723.712762872103;29668.258293542833;31129;32150.51774223435;32359.51460728138;50871.23693144532;51035.74482127566;51056.23415648694;51403;52418.73790631023;43175.784121079196;43744.78127609342;44841.103177935605;45144.54855451403;45851.541484584726;45182.54817451915;45830.31254531118;45933.540664592925;46069.30896036629;46213.53786462227;44191;44602.330965034904;44728;44973.32540011968;45178.77410612926;37753;39510.80244598759;39927.80036099801;40227.59772402239;40475.59524404836;29744.02559744095;29802;30117.247068823453;30124.698753012188;30248.84875575608 06:08:29 INFO - PROCESS | 8167 | |2;jquery.html;398.56954489151735;412.46997608073633;418.6169654765889;420.2121023081723;425.6297021591214;18744.812551874493;20323.49191270217;20567;20962.580748385022;21223.151073957062;19629.803701962977;19809.20763169475;20027.799722002776;20485.07817148228;20813.375598732026;5823.82528524145;6078.756849726005;6079.1793107930525;6086.269647642289;6086.665233412161;5709.8287051388315;5833.737481813308;5872.442117998805;5954.732037058343;6036.577439579231;5841.766329346821;5843.64938103713;5844.26946631671;5844.357120716718;5845.09401042839;5628.718564071801;5828.242328497289;5833.766649334021;5860.150278209636;5893.322267939199;5298.2052692096495;5304.336957880265;5320.76056577455;5325.653832500875;5325.653832500914;23772.76227237723;23938.401539961465;24005.639915401283;24046.158384456634;24073;2445.7431969643108;2506.2105436787538;2508.611165269386;2557.9872100639564;2675.779103344239;14660.193689347081;14908.62728431787;14929.701405971928;15079.47221847241;15364;2014.2849288502664;2015.617032763785;2062.3091264426434;2153.4616345913523;2161.8594791338514;51570.22644660333;75300;84614;85297.57351213266;85860.57069714612;10812.837807432894;11200.999999999836;11224.494897729459;11596.594119205956;11651.76696466066;16359.754603680954;16447.506574802774;16462.176891155395;16476.258568364454;16490.17549122539;8443;8881.600327985256;8996.550172491348;9002.50486223264;9045.095490451034;8753.343499237455;8815.779605509913;8844.201193689865;8862;8983;6959.164900212007;7091.716331346688;7121.323474269936;7128.857422851514;7150.713971441188;2067.131804642054;2114.4713821544615;2118.089221634681;2134.381029501458;2153.8061574458375;816.1797393619374;929.0941332201049;948.4735971535864;1083.5828206140534;1097.9066779323687;20258.594828103356;20341.694874576893;20392.694109588367;20466.38600841977;20631.69052464214;1031.0256807317014;1065.7122576904349;1066.328213225663;1087.586717047517;1112.6759156603616;10924.836127458095;11812.995895348991;11898.524059037542;11963.162578619413;12032.217905836093;508799;510822;514253;514514.7097058038;520634;78035;82344.58827705943;90914;93363;99976.06510291994;1038.2732087538752;1046.6284469013542;1092.2354351953663;1093.753905371301;1094.9781004379868;17589.560260993065;17728.46814595564;17758.644827103126;17771;18417.53956151107;40438.39342409925;42851.78574107109;43877.341839873065;44172.779136104116;44198.55801441945;54994;61040.38959610347;62665;62688.68655656693;63256.36743632505;8463.49219046859;8490.278326342082;8768.912310876809;8927.375083744075;9249;13033.869661303266;13268.93365533166;13508.729825403241;13645.249511276976;13698.315084245947;11035.44822758875;11581.131415144066;11655.76688466243;11973.880261197277;12095.516179352728;11620.070394368262;11801.114916381133;11940.641780746591;11966.940165299466;12129.332886691316;11426.885731142582;11616.186866919235;11806.645800625995;12181.817272741093;12227.572034978733;8925.018247992586;8961.686340978034;9169.266458683423;9252.95373523128;9412.623495060121;9359.438433694;11734.119941004288;11853.407329633656;11988.880111198776;12571.1200215984 06:08:29 INFO - PROCESS | 8167 | |3;mootools.html;1440.0495672855914;1515.0606623893186;1638.9754153687697;1815.1922394534422;1823.7082066869295;8635.78410539736;9305.674301399453;9307;9309.99999999999;9312.441253524794;8063;8246.587670616474;8647.0488246293;8843.292536597073;9134.223590994774;2610.8955641774305;2637.5516162252366;2640.815142939995;2641.300055485298;2647.4440367522843;2523.873806309677;2571.922842314724;2581.7031041430196;2582.0575489946127;2583.173384516955;2579.6259542366347;2582.3415029167536;2600.93497662559;2613.3858543242322;2615.4115324052127;2516.8615726134963;2525.330787341356;2527.8356906801;2543.351445381416;2551.783098436635;2514.7736703696573;2523.558377283968;2531.5696331623667;2562.897484100634;2567.1271767599105;9304.395214311047;9498.762530936781;9510.90489095114;9516.23870090391;9527.428354298765;5629;5719.370869204384;5755;5787.594868359217;5790.218320526717;3652.1600031992525;3738.140227747633;3789.696824254053;3808.371618682914;3819.4079917612817;1181.7636472705494;1238.3591740943286;1253.9059570532247;1255.039894480723;1276.2278821313064;12336;12492.81260781089;12508.249505029728;12523.499060037588;12535.874641253562;5072.847814565569;5191.169412893994;5224.947750522522;5246.31797866275;5253.711045892513;10634.41510716918;10639.202059845542;10639.574417023387;10643;10650.840237396445;5808.796692115756;5838.970805146032;5839.124131380327;5853.765849365977;5857.4435428634215;4529.252673308933;4632.652551058684;4981.750912454363;5004.049230646166;5353;4340;4380.342948557742;4401.097774956126;4481.193385190697;4487.573680500347;1424.7008128292966;1435.103060587133;1457.6137323609253;1462.722082804264;1464.736347457468;930.297625292913;976.770458942148;1013.3970287678819;1020.403064207447;1028.228828378716;5873.009530279091;5947.732352044169;6072.423119803611;6131.50947924165;6183.134361189437;471.05318310196066;472.4967909176716;476.04077783266746;506.68585477004495;511.51406164144214;4093.1199792044854;4283.20760659279;4304.988327742978;4321.762303073361;4388.05656783793;10990.560377584807;11229.943850280697;11326.433678316216;11334.263272887236;11336.43317834105;11156.386398747984;11212.719682008015;11238.887611123784;11250.268732532522;11256.493457794419;8087.393445491612;8361.331093512505;8408.411411201158;8430.747077587683;8435.873461898076;6241.96879015602;6307.337729538516;6336.873262534816;6377.904331435125;6391.808245752635;10090.495475226357;10516.474176291002;10589;10589.752046292724;10594.523246453773;10756.569737210737;10807.243492955418;10918.344899306067;11326.32042077478;11328.433578321215;7418.295261950106;7577.696892124253;7901.091374491777;8103.716369927024;8205.220504052106;8909.50997695107;9395.06049395055;9409.01205373426;9411.43531388119;9461.574229159842;7957.721479748181;8033.758987230392;8459.534725590152;8504.659813607386;8645.092265312303;8149.674013039412;8187.181281871765;8264.917350826414;8300.335973122257;8361.95819020901;7172.246914074156;7386;7451.068616422947;7461.701531938662;7526.209747976603;5077.543021128116;5189.4032186299055;5332.866678333073;5344.11822049373;5413.323334583177;5354;5539.446055394428;5622.803201887914;5673.74468148926;5803.535717142703 06:08:29 INFO - PROCESS | 8167 | |4;prototype.html;322.8837618457355;344.6742828027515;348.55385107062966;354.3939862834554;356.7823627587171;5553.694546799924;5603.215549823028;5621.550275977922;5631.887362252753;5662.839117980814;5527.39198688144;5563.749631266593;5567.693776842272;5575.2473416088815;5584.888302233963;4192.517860446042;4408.97795511022;4411.720601025707;4414.492333381654;4426.933595996063;3935.60643935607;4278.251306021434;4284.614384705376;4376.752625501733;4385.10105428388;4369;4375.037491751809;4376.781160941956;4383.312424716475;4386.144701783153;4400.669949753781;4402.955970440286;4404.744647775385;4408.40486534317;4415.66882483815;3870.283997460451;3905.2775236581324;3912.8043597819997;3939.9606003940166;3958.148997965451;5388.407275199725;5390.649607775521;5403.891922161574;5408.242846001563;5409.512384094405;5025.773840177201;5051.696898186084;5059.772310246011;5062.1141300272675;5087.821926232564;5614.466625670555;5760.452756988121;5810.356287889001;5813.186153938452;5827.825165245049;4288.485381754178;4298.957010429887;4299.74201547905;4308.569143085698;4340.826366945318;5685.640459209423;5878.353381128115;6111.938880611226;6134;6149.938500615026;4295.420118284054;4387.27609944362;4433.578810013044;4440.222960981815;4440.555944405533;4504.076664283814;4510.684252102387;4541.864533866534;4550.408446901882;4559.472576686847;4874;5083.474957512805;5084.694918304914;5086.109930762102;5120.48795120485;5773.509251713567;5802.839432113594;5814.883702325929;5823.82528524145;5938.524918006549;1522.8781697464176;1545.3509525999107;1547.2418514927604;1552.9595171235073;1561.149173700336;960.70698436976;1011.9797604047877;1013.8290274732695;1018.7911478146962;1033.9534720937577;4990.800367985313;4991.575716064175;5008.622628777042;5010.549050585465;5033.270175824485;5180.922286165711;5196.246544251062;5212.7914883405;5259.211867964834;5263.473652634706;4940.382452193476;5020.422651395063;5024.62315326352;5378.757955891994;5791.797287094932;3178.9509461877524;3189.7767156298837;3191.824449655291;3203.8718451262152;3210.807351558914;6064.151018857364;6210.50315974721;6235.469985051322;6246.187995560639;6277.497800175975;6089.208402907682;6115.6330620162935;6131.294901086343;6172.69136543171;6185.907211391833;6106.832074613537;6147.200863887666;6152.16945712332;6158.230221222348;6162.476189523851;5856.121581762599;5962.284525856925;5998.400159983967;6026.789062382795;6123.2652081750475;5942;5950.9702451487465;5952.821415357546;5957.642541447353;5980.312264089685;6003.129546215861;6032.1856549365275;6131.693415329127;6181.5363847710705;6194.690265486617;4313.331433627793;4331.675124365622;4334.32817913224;4334.591257841151;4335.263005289045;5861.472467477947;6043.607165534227;6046.30467496226;6062.363451837494;6080.391960803884;5829.735348205018;5832.416758324133;5849.210356601804;5862.361937128395;5877.4122587740885;5808.680522571299;5819.330776960534;5870.559708022;5876.676782776988;5906.320773111147;5695.572832037697;5768.946158475829;5802.6808525531505;5823.4176582343125;5856.443637854397;5863.185670878088;5867.237259156454;5874.471297583238;5879.824035192893;5882.205902203148;5538.978272930432;5743.195952566561;5780.508656764222;5804.791526143512;5806.01297779387 06:08:29 INFO - PROCESS | 8167 | |5;yui.html;840.684743221292;847.8897743293375;880.929525637949;882.9867551986721;917.0685429678236;16944.23750931208;18119.275228990857;18189.545261368472;18239.452816415513;18248.45254642361;15059;15131.773023404658;16379.754303685455;17172.656546869086;17254.56863578408;735.33819562394;756.092688773474;857.4812238595654;879.5382424227267;884.5621417398364;855.179028132993;865.4417900454204;880.9911900880974;882.3162049411725;883.3551507399602;913.447364344572;913.8492148795441;915.0254978447931;919.3013309884502;919.9034101419355;910.1171863292595;913.2739472119614;913.5660561233394;913.7761248494128;914.6158613382395;672.4317951331118;672.492268337407;673.323310073378;673.7237732529688;673.8854394752904;15668.608284792857;15820.920895395564;15827;15840.76238856418;15902.204889755581;15517.301721422451;15681.764773528406;15694.686106277924;16261;16360.83639163605;13177.604671859859;13875.306234688325;13921.860781392157;14031.43874245029;14239.359228834728;4168.749875007509;4178.623923846838;4219.135077309144;4278.850240241577;4290.785460726951;89500.55249723775;89681.55159224228;90021;90438;90749.54625226898;12399.75200495985;12851.293178875065;12880.484780608858;12921.483140674456;13005.674858128434;23890.52218955611;23988.760112399003;24032.279031629078;24041.759582403953;24103.15638952628;9138.588763505659;9207.309451791009;9332.300077494216;9416.293777966679;9420.528973551294;4963.206903251882;5192.636515443883;5234.528892399626;5309.469053094737;5325.680459172462;3996.800159991989;4160.375943608423;4165.937510937339;4166.541680415152;4177.832886684499;688.9862202755917;693.1924308181013;695.0547255732301;698.5354739098544;720.771085299563;775.3719487215374;787.2993036197788;792.5086446403267;796.0964305513285;814.4339683919619;10232.567440558329;10576.947115264375;10713.303635263683;11323.43382830855;11418.143639227092;681.9727210911508;759.4038679636569;776.5573623034816;781.5440695762363;781.7498400511895;4931.4821943696115;5209.426963034063;5266.47335266478;5379.488948549882;5409.188621706697;99599;128324.35837820751;129513;129591;130511;105532.47233763782;107477;108433;108670.45664771783;109039.45480272548;76732.23267767363;77444.61277693576;80252.19747802564;84030.57984709916;93357.53321233351;10129.613554045642;10200.846987295345;10241.283110182216;10286.794264114826;10471.842922356323;56250.74997000074;56264.718676407996;57494.42505574891;58041.41958580529;58496;73546;75564;75812.62093689496;76607;79100;13893.667973960213;13933.258342707162;14453.927730361282;14491.130532168103;14693.265336733335;14706.77939830882;14919.104853708812;14954.40182392692;14960.551183464513;15152.242387880342;14086.436542538593;14178.787318190442;14490;14642;14865;14818.851811482178;15116.773248401503;16139.354425823305;16191.433299834449;16327.346906124098;14724.779128313297;15046.247687615356;15069.924650376677;15919.920400397923;16294.429694961094;11653.6503904883;12316.753664926831;12328.876711232773;12635.74728505443;12708.237505749685;12230.388480575757;12242.387880605756;12281.201721888048;12465.563705270271;12509.43707533145 06:08:29 INFO - PROCESS | 8167 | __end_tp_report 06:08:29 INFO - PROCESS | 8167 | __start_cc_report 06:08:29 INFO - PROCESS | 8167 | _x_x_mozilla_cycle_collect,895 06:08:29 INFO - PROCESS | 8167 | __end_cc_report 06:08:29 INFO - PROCESS | 8167 | __startTimestamp1479996509155__endTimestamp 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | ------- Summary: start ------- 06:08:29 INFO - PROCESS | 8167 | Number of tests: 6 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#0] dojo.html Cycles:165 Average:5646.70 Median:5917.14 stddev:655.40 (11.1%) stddev-sans-first:627.49 06:08:29 INFO - PROCESS | 8167 | Values: 3151.1 3197.5 3208.1 3211.7 3252.2 5690.3 5760.9 5769.7 5789.2 5795.4 5629.5 5667.3 5686.5 5693.7 5694.7 5129.3 5173.6 5178.1 5178.6 5239.4 5137.1 5250.7 5266.8 5268.6 5291.6 5078.3 5120.8 5206.5 5238.3 5255.1 5106.6 5124.3 5127.3 5206.6 5212.2 5102.1 5131.1 5223.6 5233.6 5264.0 5427.5 5473.0 5512.9 5567.2 5574.5 6001.6 6016.6 6101.3 6105.3 6109.8 6158.1 6160.4 6160.7 6172.3 6173.6 5566.4 5585.4 5631.7 5644.2 5644.8 6220.3 6243.2 6260.8 6261.9 6268.5 5975.2 5994.3 5996.6 5999.4 6024.9 5774.3 5830.7 5903.9 5966.7 6076.9 5982.0 5987.8 5988.7 6025.0 6029.5 5948.7 5962.6 6005.4 6008.0 6036.7 4558.2 4572.8 4620.5 4634.7 4634.9 4104.6 4106.5 4111.7 4158.1 4171.1 5786.8 5795.3 5795.9 5798.5 5828.7 5943.6 6011.5 6060.2 6090.3 6093.7 5641.1 5665.2 5677.8 5750.3 5782.3 5181.1 5202.7 5210.1 5218.2 5219.5 6081.1 6185.0 6210.9 6220.5 6224.9 6035.5 6078.3 6090.8 6160.5 6161.0 6319.9 6325.0 6329.1 6332.0 6349.1 5849.1 6011.2 6017.1 6019.0 6020.6 6000.2 6073.1 6079.6 6093.4 6207.6 6004.7 6045.3 6064.4 6066.1 6068.1 6051.4 6061.8 6062.3 6063.7 6066.2 5828.4 5904.9 5905.7 5957.5 5964.3 6052.6 6072.4 6073.2 6086.8 6095.7 5917.1 5953.6 5971.0 5983.0 5983.1 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#1] ext.html Cycles:180 Average:62886.74 Median:223816.30 stddev:122094.63 (54.6%) stddev-sans-first:122347.56 06:08:29 INFO - PROCESS | 8167 | Values: 597.6 611.6 633.2 635.2 648.7 33574.7 46348.3 47198.5 47303.3 47335.5 48108.6 48347.5 48782.5 48811.0 48846.5 8535.2 9276.2 9439.3 9480.6 9484.7 8378.5 11073.1 11293.8 11309.9 11689.0 11446.1 11497.2 11506.2 11522.1 11523.8 11162.8 11212.2 11250.8 11254.9 11266.4 10902.2 10954.4 10969.3 10978.5 10980.1 45008.0 45234.8 45245.0 45260.5 45367.5 3737.2 3743.1 4401.4 4421.5 4456.7 34293.7 34404.8 34689.3 34693.0 35158.3 4733.1 4755.7 4767.1 4840.2 4883.8 355763.2 358113.0 358299.0 359032.0 359346.0 65239.0 65254.0 65649.7 65683.3 65770.7 40801.0 41881.0 42067.4 68813.0 69019.3 18291.3 18341.1 18415.9 18416.6 18468.7 13150.1 13595.0 13692.2 13746.7 13908.7 20383.8 20941.2 21140.0 21222.2 21353.5 7341.9 7442.6 7587.0 7643.0 7811.5 994.8 1001.2 1053.2 1102.8 1157.3 33566.8 33628.5 34323.7 34482.5 35061.5 1086.3 1119.9 1129.7 1189.5 1232.7 18203.5 18407.7 18461.6 18494.7 18508.3 581313.0 584780.0 585858.0 586601.0 588325.0 63555.4 64241.4 64244.4 64284.7 64315.7 1320.7 1358.3 1409.1 1418.3 1448.4 30740.8 34836.7 35416.1 35752.5 35760.0 55457.0 55641.7 55873.2 56119.7 56445.7 407157.0 407515.0 408219.0 408648.0 409055.0 28723.7 29668.3 31129.0 32150.5 32359.5 50871.2 51035.7 51056.2 51403.0 52418.7 43175.8 43744.8 44841.1 45144.5 45851.5 45182.5 45830.3 45933.5 46069.3 46213.5 44191.0 44602.3 44728.0 44973.3 45178.8 37753.0 39510.8 39927.8 40227.6 40475.6 29744.0 29802.0 30117.2 30124.7 30248.8 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#2] jquery.html Cycles:180 Average:30076.37 Median:13259.37 stddev:84431.05 (636.8%) stddev-sans-first:84638.49 06:08:29 INFO - PROCESS | 8167 | Values: 398.6 412.5 418.6 420.2 425.6 18744.8 20323.5 20567.0 20962.6 21223.2 19629.8 19809.2 20027.8 20485.1 20813.4 5823.8 6078.8 6079.2 6086.3 6086.7 5709.8 5833.7 5872.4 5954.7 6036.6 5841.8 5843.6 5844.3 5844.4 5845.1 5628.7 5828.2 5833.8 5860.2 5893.3 5298.2 5304.3 5320.8 5325.7 5325.7 23772.8 23938.4 24005.6 24046.2 24073.0 2445.7 2506.2 2508.6 2558.0 2675.8 14660.2 14908.6 14929.7 15079.5 15364.0 2014.3 2015.6 2062.3 2153.5 2161.9 51570.2 75300.0 84614.0 85297.6 85860.6 10812.8 11201.0 11224.5 11596.6 11651.8 16359.8 16447.5 16462.2 16476.3 16490.2 8443.0 8881.6 8996.6 9002.5 9045.1 8753.3 8815.8 8844.2 8862.0 8983.0 6959.2 7091.7 7121.3 7128.9 7150.7 2067.1 2114.5 2118.1 2134.4 2153.8 816.2 929.1 948.5 1083.6 1097.9 20258.6 20341.7 20392.7 20466.4 20631.7 1031.0 1065.7 1066.3 1087.6 1112.7 10924.8 11813.0 11898.5 11963.2 12032.2 508799.0 510822.0 514253.0 514514.7 520634.0 78035.0 82344.6 90914.0 93363.0 99976.1 1038.3 1046.6 1092.2 1093.8 1095.0 17589.6 17728.5 17758.6 17771.0 18417.5 40438.4 42851.8 43877.3 44172.8 44198.6 54994.0 61040.4 62665.0 62688.7 63256.4 8463.5 8490.3 8768.9 8927.4 9249.0 13033.9 13268.9 13508.7 13645.2 13698.3 11035.4 11581.1 11655.8 11973.9 12095.5 11620.1 11801.1 11940.6 11966.9 12129.3 11426.9 11616.2 11806.6 12181.8 12227.6 8925.0 8961.7 9169.3 9253.0 9412.6 9359.4 11734.1 11853.4 11988.9 12571.1 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#3] mootools.html Cycles:180 Average:6107.41 Median:471.77 stddev:3403.75 (721.5%) stddev-sans-first:3395.22 06:08:29 INFO - PROCESS | 8167 | Values: 1440.0 1515.1 1639.0 1815.2 1823.7 8635.8 9305.7 9307.0 9310.0 9312.4 8063.0 8246.6 8647.0 8843.3 9134.2 2610.9 2637.6 2640.8 2641.3 2647.4 2523.9 2571.9 2581.7 2582.1 2583.2 2579.6 2582.3 2600.9 2613.4 2615.4 2516.9 2525.3 2527.8 2543.4 2551.8 2514.8 2523.6 2531.6 2562.9 2567.1 9304.4 9498.8 9510.9 9516.2 9527.4 5629.0 5719.4 5755.0 5787.6 5790.2 3652.2 3738.1 3789.7 3808.4 3819.4 1181.8 1238.4 1253.9 1255.0 1276.2 12336.0 12492.8 12508.2 12523.5 12535.9 5072.8 5191.2 5224.9 5246.3 5253.7 10634.4 10639.2 10639.6 10643.0 10650.8 5808.8 5839.0 5839.1 5853.8 5857.4 4529.3 4632.7 4981.8 5004.0 5353.0 4340.0 4380.3 4401.1 4481.2 4487.6 1424.7 1435.1 1457.6 1462.7 1464.7 930.3 976.8 1013.4 1020.4 1028.2 5873.0 5947.7 6072.4 6131.5 6183.1 471.1 472.5 476.0 506.7 511.5 4093.1 4283.2 4305.0 4321.8 4388.1 10990.6 11229.9 11326.4 11334.3 11336.4 11156.4 11212.7 11238.9 11250.3 11256.5 8087.4 8361.3 8408.4 8430.7 8435.9 6242.0 6307.3 6336.9 6377.9 6391.8 10090.5 10516.5 10589.0 10589.8 10594.5 10756.6 10807.2 10918.3 11326.3 11328.4 7418.3 7577.7 7901.1 8103.7 8205.2 8909.5 9395.1 9409.0 9411.4 9461.6 7957.7 8033.8 8459.5 8504.7 8645.1 8149.7 8187.2 8264.9 8300.3 8362.0 7172.2 7386.0 7451.1 7461.7 7526.2 5077.5 5189.4 5332.9 5344.1 5413.3 5354.0 5539.4 5622.8 5673.7 5803.5 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#4] prototype.html Cycles:180 Average:4899.89 Median:5406.07 stddev:1417.01 (26.2%) stddev-sans-first:1378.71 06:08:29 INFO - PROCESS | 8167 | Values: 322.9 344.7 348.6 354.4 356.8 5553.7 5603.2 5621.6 5631.9 5662.8 5527.4 5563.7 5567.7 5575.2 5584.9 4192.5 4409.0 4411.7 4414.5 4426.9 3935.6 4278.3 4284.6 4376.8 4385.1 4369.0 4375.0 4376.8 4383.3 4386.1 4400.7 4403.0 4404.7 4408.4 4415.7 3870.3 3905.3 3912.8 3940.0 3958.1 5388.4 5390.6 5403.9 5408.2 5409.5 5025.8 5051.7 5059.8 5062.1 5087.8 5614.5 5760.5 5810.4 5813.2 5827.8 4288.5 4299.0 4299.7 4308.6 4340.8 5685.6 5878.4 6111.9 6134.0 6149.9 4295.4 4387.3 4433.6 4440.2 4440.6 4504.1 4510.7 4541.9 4550.4 4559.5 4874.0 5083.5 5084.7 5086.1 5120.5 5773.5 5802.8 5814.9 5823.8 5938.5 1522.9 1545.4 1547.2 1553.0 1561.1 960.7 1012.0 1013.8 1018.8 1034.0 4990.8 4991.6 5008.6 5010.5 5033.3 5180.9 5196.2 5212.8 5259.2 5263.5 4940.4 5020.4 5024.6 5378.8 5791.8 3179.0 3189.8 3191.8 3203.9 3210.8 6064.2 6210.5 6235.5 6246.2 6277.5 6089.2 6115.6 6131.3 6172.7 6185.9 6106.8 6147.2 6152.2 6158.2 6162.5 5856.1 5962.3 5998.4 6026.8 6123.3 5942.0 5951.0 5952.8 5957.6 5980.3 6003.1 6032.2 6131.7 6181.5 6194.7 4313.3 4331.7 4334.3 4334.6 4335.3 5861.5 6043.6 6046.3 6062.4 6080.4 5829.7 5832.4 5849.2 5862.4 5877.4 5808.7 5819.3 5870.6 5876.7 5906.3 5695.6 5768.9 5802.7 5823.4 5856.4 5863.2 5867.2 5874.5 5879.8 5882.2 5539.0 5743.2 5780.5 5804.8 5806.0 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - PROCESS | 8167 | [#5] yui.html Cycles:180 Average:22494.07 Median:4163.16 stddev:32010.36 (768.9%) stddev-sans-first:32058.86 06:08:29 INFO - PROCESS | 8167 | Values: 840.7 847.9 880.9 883.0 917.1 16944.2 18119.3 18189.5 18239.5 18248.5 15059.0 15131.8 16379.8 17172.7 17254.6 735.3 756.1 857.5 879.5 884.6 855.2 865.4 881.0 882.3 883.4 913.4 913.8 915.0 919.3 919.9 910.1 913.3 913.6 913.8 914.6 672.4 672.5 673.3 673.7 673.9 15668.6 15820.9 15827.0 15840.8 15902.2 15517.3 15681.8 15694.7 16261.0 16360.8 13177.6 13875.3 13921.9 14031.4 14239.4 4168.7 4178.6 4219.1 4278.9 4290.8 89500.6 89681.6 90021.0 90438.0 90749.5 12399.8 12851.3 12880.5 12921.5 13005.7 23890.5 23988.8 24032.3 24041.8 24103.2 9138.6 9207.3 9332.3 9416.3 9420.5 4963.2 5192.6 5234.5 5309.5 5325.7 3996.8 4160.4 4165.9 4166.5 4177.8 689.0 693.2 695.1 698.5 720.8 775.4 787.3 792.5 796.1 814.4 10232.6 10576.9 10713.3 11323.4 11418.1 682.0 759.4 776.6 781.5 781.7 4931.5 5209.4 5266.5 5379.5 5409.2 99599.0 128324.4 129513.0 129591.0 130511.0 105532.5 107477.0 108433.0 108670.5 109039.5 76732.2 77444.6 80252.2 84030.6 93357.5 10129.6 10200.8 10241.3 10286.8 10471.8 56250.7 56264.7 57494.4 58041.4 58496.0 73546.0 75564.0 75812.6 76607.0 79100.0 13893.7 13933.3 14453.9 14491.1 14693.3 14706.8 14919.1 14954.4 14960.6 15152.2 14086.4 14178.8 14490.0 14642.0 14865.0 14818.9 15116.8 16139.4 16191.4 16327.3 14724.8 15046.2 15069.9 15919.9 16294.4 11653.7 12316.8 12328.9 12635.7 12708.2 12230.4 12242.4 12281.2 12465.6 12509.4 06:08:29 INFO - PROCESS | 8167 | -------- Summary: end -------- 06:08:29 INFO - PROCESS | 8167 | 06:08:29 INFO - TEST-INFO | 8167: exit 0 06:08:29 INFO - TEST-OK | dromaeo_css | took 1112935ms 06:08:29 INFO - TEST-START | kraken 06:08:29 INFO - operating with platform_type : linux_ 06:08:29 INFO - Initialising browser for kraken test... 06:08:29 INFO - TEST-INFO | started process 8474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLRWE6S/profile http://localhost:49779/getInfo.html) 06:08:33 INFO - PROCESS | 8474 | __metrics Screen width/height:1600/1200 06:08:33 INFO - PROCESS | 8474 | colorDepth:24 06:08:33 INFO - PROCESS | 8474 | Browser inner width/height: 1024/697 06:08:33 INFO - PROCESS | 8474 | __metrics 06:08:34 INFO - PROCESS | 8474 | 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" 06:08:34 INFO - PROCESS | 8474 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:34 INFO - PROCESS | 8474 | console.error: PushService: 06:08:34 INFO - PROCESS | 8474 | stateChangeProcessEnqueue: Error transitioning state 06:08:34 INFO - PROCESS | 8474 | UnknownError 06:08:35 INFO - TEST-INFO | 8474: exit 0 06:08:35 INFO - Browser initialized. 06:08:35 INFO - Running cycle 1/1 for kraken test... 06:08:35 INFO - TEST-INFO | started process 8566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLRWE6S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:47 INFO - PROCESS | 8566 | RSS: Main: 142970880 06:08:47 INFO - PROCESS | 8566 | 06:08:49 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49779/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:50 INFO - PROCESS | 8566 | RSS: Main: 186159104 06:08:50 INFO - PROCESS | 8566 | 06:08:52 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49779/tests/kraken/driver.html?testName=audio-dft) 06:08:53 INFO - PROCESS | 8566 | RSS: Main: 173613056 06:08:53 INFO - PROCESS | 8566 | 06:08:56 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49779/tests/kraken/driver.html?testName=audio-fft) 06:08:56 INFO - PROCESS | 8566 | RSS: Main: 265519104 06:08:56 INFO - PROCESS | 8566 | 06:08:58 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49779/tests/kraken/driver.html?testName=audio-oscillator) 06:08:59 INFO - PROCESS | 8566 | RSS: Main: 170987520 06:08:59 INFO - PROCESS | 8566 | 06:09:01 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:02 INFO - PROCESS | 8566 | RSS: Main: 173072384 06:09:02 INFO - PROCESS | 8566 | 06:09:05 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49779/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:05 INFO - PROCESS | 8566 | RSS: Main: 209227776 06:09:05 INFO - PROCESS | 8566 | 06:09:09 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49779/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:09 INFO - PROCESS | 8566 | RSS: Main: 208457728 06:09:09 INFO - PROCESS | 8566 | 06:09:12 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49779/tests/kraken/driver.html?testName=json-parse-financial) 06:09:12 INFO - PROCESS | 8566 | RSS: Main: 208363520 06:09:12 INFO - PROCESS | 8566 | 06:09:14 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:15 INFO - PROCESS | 8566 | RSS: Main: 170274816 06:09:15 INFO - PROCESS | 8566 | 06:09:16 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:17 INFO - PROCESS | 8566 | RSS: Main: 178204672 06:09:17 INFO - PROCESS | 8566 | 06:09:19 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:19 INFO - PROCESS | 8566 | RSS: Main: 186781696 06:09:19 INFO - PROCESS | 8566 | 06:09:22 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:23 INFO - PROCESS | 8566 | RSS: Main: 195522560 06:09:23 INFO - PROCESS | 8566 | 06:09:25 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:26 INFO - PROCESS | 8566 | RSS: Main: 191561728 06:09:26 INFO - PROCESS | 8566 | 06:09:27 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:49779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49779/tests/kraken/driver.html?testName=ai-astar) 06:09:28 INFO - PROCESS | 8566 | RSS: Main: 241901568 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | __start_tp_report 06:09:28 INFO - PROCESS | 8566 | _x_x_mozilla_page_load 06:09:28 INFO - PROCESS | 8566 | _x_x_mozilla_page_load_details 06:09:28 INFO - PROCESS | 8566 | |i|pagename|runs| 06:09:28 INFO - PROCESS | 8566 | |0;ai-astar;111;112;111;109;112;108;109;109;111;110 06:09:28 INFO - PROCESS | 8566 | |1;audio-beat-detection;149;116;114;152;118;120;120;124;147;120 06:09:28 INFO - PROCESS | 8566 | |2;audio-dft;160;160;159;159;159;160;158;160;160;158 06:09:28 INFO - PROCESS | 8566 | |3;audio-fft;75;76;75;109;77;76;79;76;100;76 06:09:28 INFO - PROCESS | 8566 | |4;audio-oscillator;81;81;131;81;81;82;105;82;82;112 06:09:28 INFO - PROCESS | 8566 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;116;117;117 06:09:28 INFO - PROCESS | 8566 | |6;imaging-darkroom;146;147;146;145;147;146;147;146;146;146 06:09:28 INFO - PROCESS | 8566 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;94 06:09:28 INFO - PROCESS | 8566 | |8;json-parse-financial;51;49;49;49;52;49;51;49;49;49 06:09:28 INFO - PROCESS | 8566 | |9;json-stringify-tinderbox;58;59;60;60;61;58;59;59;60;60 06:09:28 INFO - PROCESS | 8566 | |10;stanford-crypto-aes;73;73;73;74;73;73;73;74;74;73 06:09:28 INFO - PROCESS | 8566 | |11;stanford-crypto-ccm;121;118;119;121;122;119;129;122;159;122 06:09:28 INFO - PROCESS | 8566 | |12;stanford-crypto-pbkdf2;150;151;152;152;153;152;153;157;152;151 06:09:28 INFO - PROCESS | 8566 | |13;stanford-crypto-sha256-iterative;62;61;62;62;63;63;61;62;60;61 06:09:28 INFO - PROCESS | 8566 | __end_tp_report 06:09:28 INFO - PROCESS | 8566 | __start_cc_report 06:09:28 INFO - PROCESS | 8566 | _x_x_mozilla_cycle_collect,1539 06:09:28 INFO - PROCESS | 8566 | __end_cc_report 06:09:28 INFO - PROCESS | 8566 | __startTimestamp1479996568132__endTimestamp 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | ------- Summary: start ------- 06:09:28 INFO - PROCESS | 8566 | Number of tests: 14 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.40 (1.3%) stddev-sans-first:1.45 06:09:28 INFO - PROCESS | 8566 | Values: 111.0 112.0 111.0 109.0 112.0 108.0 109.0 109.0 111.0 110.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:122.00 stddev:15.00 (12.3%) stddev-sans-first:13.86 06:09:28 INFO - PROCESS | 8566 | Values: 149.0 116.0 114.0 152.0 118.0 120.0 120.0 124.0 147.0 120.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#2] audio-dft Cycles:10 Average:159.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 06:09:28 INFO - PROCESS | 8566 | Values: 160.0 160.0 159.0 159.0 159.0 160.0 158.0 160.0 160.0 158.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.15 (16.0%) stddev-sans-first:12.63 06:09:28 INFO - PROCESS | 8566 | Values: 75.0 76.0 75.0 109.0 77.0 76.0 79.0 76.0 100.0 76.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.00 stddev:17.87 (22.1%) stddev-sans-first:18.52 06:09:28 INFO - PROCESS | 8566 | Values: 81.0 81.0 131.0 81.0 81.0 82.0 105.0 82.0 82.0 112.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:09:28 INFO - PROCESS | 8566 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:09:28 INFO - PROCESS | 8566 | Values: 146.0 147.0 146.0 145.0 147.0 146.0 147.0 146.0 146.0 146.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:09:28 INFO - PROCESS | 8566 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.00 stddev:1.16 (2.4%) stddev-sans-first:1.13 06:09:28 INFO - PROCESS | 8566 | Values: 51.0 49.0 49.0 49.0 52.0 49.0 51.0 49.0 49.0 49.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:0.88 06:09:28 INFO - PROCESS | 8566 | Values: 58.0 59.0 60.0 60.0 61.0 58.0 59.0 59.0 60.0 60.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 06:09:28 INFO - PROCESS | 8566 | Values: 73.0 73.0 73.0 74.0 73.0 73.0 73.0 74.0 74.0 73.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:122.00 stddev:12.25 (10.0%) stddev-sans-first:12.90 06:09:28 INFO - PROCESS | 8566 | Values: 121.0 118.0 119.0 121.0 122.0 119.0 129.0 122.0 159.0 122.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:152.00 stddev:1.89 (1.2%) stddev-sans-first:1.81 06:09:28 INFO - PROCESS | 8566 | Values: 150.0 151.0 152.0 152.0 153.0 152.0 153.0 157.0 152.0 151.0 06:09:28 INFO - PROCESS | 8566 | 06:09:28 INFO - PROCESS | 8566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 06:09:28 INFO - PROCESS | 8566 | Values: 62.0 61.0 62.0 62.0 63.0 63.0 61.0 62.0 60.0 61.0 06:09:28 INFO - PROCESS | 8566 | -------- Summary: end -------- 06:09:28 INFO - PROCESS | 8566 | 06:09:29 INFO - TEST-INFO | 8566: exit 0 06:09:29 INFO - TEST-OK | kraken | took 59220ms 06:09:29 INFO - SUITE-END | took 1172s 06:09:29 INFO - Completed test suite (00:19:32) 06:09:29 INFO - javascript benchmark 06:09:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.1019359482543, 3197.4884018557036, 3208.1017315151757, 3211.7109460148595, 3252.170696472399, 5690.260266165398, 5760.913586296198, 5769.740361683724, 5789.218455508505, 5795.391483894188, 5629.465200805927, 5667.263255776754, 5686.459786320293, 5693.686847223401, 5694.658320500773, 5129.281900533928, 5173.6119791015635, 5178.14560597501, 5178.637495375326, 5239.3712754469325, 5137.101007323722, 5250.7374631268285, 5266.81566145185, 5268.5521730652945, 5291.5766738661005, 5078.339815823938, 5120.769565369549, 5206.479352064782, 5238.345206849144, 5255.106631872572, 5106.617003724736, 5124.282600435923, 5127.282180494733, 5206.583473322125, 5212.1921102228835, 5102.1071312520535, 5131.076406246874, 5223.582113430916, 5233.633645644806, 5263.973680131613, 5427.48438898304, 5473.01485732568, 5512.862178445531, 5567.220589117527, 5574.470425309589, 6001.639901605918, 6016.578839481238, 6101.328853826076, 6105.267367915834, 6109.816705498843, 6158.107074474221, 6160.383961603849, 6160.691965401712, 6172.321044685126, 6173.567850250484, 5566.387697353288, 5585.385607583163, 5631.662100273956, 5644.209810626516, 5644.802431914945, 6220.315765265817, 6243.219597550306, 6260.780872669435, 6261.9373806262265, 6268.49852011838, 5975.163477113208, 5994.280686317583, 5996.576521726119, 5999.430054144849, 6024.939750602525, 5774.2782152230975, 5830.679312637761, 5903.852403689856, 5966.701664916737, 6076.939230607637, 5982.042873140364, 5987.820365389045, 5988.700564971734, 6024.969875150597, 6029.547783916224, 5948.672822994777, 5962.582619216613, 6005.429484198994, 6007.969960150172, 6036.728347224385, 4558.2251017327135, 4572.817087316536, 4620.468646105741, 4634.72191668501, 4634.884127896762, 4104.56902025283, 4106.548279689232, 4111.650509706708, 4158.147579746144, 4171.124063946544, 5786.826395208151, 5795.304563452329, 5795.855103622359, 5798.536117110621, 5828.6502809831545, 5943.643381397043, 6011.5190784737115, 6060.2424696912885, 6090.33006369299, 6093.66484843329, 5641.12562552805, 5665.206871038058, 5677.829665110054, 5750.338711048283, 5782.306123265151, 5181.06740786662, 5202.661826981234, 5210.114280572312, 5218.217267409843, 5219.530242278213, 6081.148639190517, 6185.0, 6210.875782484415, 6220.471259942865, 6224.906626400608, 6035.456808887221, 6078.331383547895, 6090.756369745161, 6160.476359509492, 6161.045038019114, 6319.873602528016, 6325.0, 6329.145565348619, 6331.96834015827, 6349.079383489276, 5849.064149736022, 6011.158437818622, 6017.097435384728, 6019.0, 6020.608660437058, 6000.249968753906, 6073.089036644538, 6079.604825686316, 6093.421124993119, 6207.565470417027, 6004.669743164168, 6045.335013148638, 6064.363241859718, 6066.090086487062, 6068.120122582112, 6051.425114614105, 6061.818145455643, 6062.272527296753, 6063.72713227897, 6066.241719785027, 5828.446297601721, 5904.852378690567, 5905.704714764331, 5957.523398128053, 5964.284285885721, 6052.636841789506, 6072.423119803611, 6073.240844894388, 6086.847828804315, 6095.725692343766, 5917.142014407973, 5953.642781433128, 5971.0, 5983.042713166046, 5983.102534619842], "value": 5600.812527107695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6264834478451, 611.6421893192482, 633.154738424204, 635.1774452084552, 648.7048392981194, 33574.664253357456, 46348.3047754284, 47198.52801471984, 47303.29045064327, 47335.526644733545, 48108.59457027143, 48347.51652483474, 48782.51217487824, 48811.0, 48846.51153488473, 8535.189157030103, 9276.211522020636, 9439.292053096011, 9480.573374198178, 9484.66803661872, 8378.455400398985, 11073.114150867912, 11293.774124517504, 11309.886901131007, 11689.0, 11446.084313254962, 11497.195196336259, 11506.194566380356, 11522.135839812006, 11523.769524609503, 11162.832557511643, 11212.215144939817, 11250.774984500345, 11254.887451125547, 11266.380349080797, 10902.182336324728, 10954.39750813705, 10969.341839489656, 10978.451077446176, 10980.121590272758, 45008.0, 45234.77382613066, 45245.0, 45260.547394525966, 45367.54632453666, 3737.177820879402, 3743.12036671382, 4401.361802538646, 4421.535738747418, 4456.665750068725, 34293.657063429295, 34404.82797586021, 34689.30621387583, 34693.0, 35158.29683406318, 4733.100710864925, 4755.667103302771, 4767.094252092092, 4840.249761287007, 4883.8290659826735, 355763.221183895, 358113.0, 358299.0, 359032.0, 359346.0, 65239.0, 65254.0, 65649.67175164189, 65683.34316656868, 65770.67114664492, 40801.0, 41881.0, 42067.36898946518, 68813.0, 69019.3098069023, 18291.26834926588, 18341.082945852922, 18415.90792046031, 18416.631667366844, 18468.722969155475, 13150.145240559334, 13595.0, 13692.246926419142, 13746.65633359174, 13908.652283692989, 20383.79616203819, 20941.16235350569, 21140.0, 21222.151113955577, 21353.46616334573, 7341.853162936818, 7442.553446793209, 7587.0, 7642.968199293025, 7811.4922530035365, 994.7761753605381, 1001.1590264178126, 1053.173258991703, 1102.7518808268076, 1157.3056166300153, 33566.83216583901, 33628.49557256643, 34323.656763432045, 34482.48276275858, 35061.47407788885, 1086.342762628614, 1119.8600174978128, 1129.667480931256, 1189.5301355964518, 1232.7411243638937, 18203.452706520093, 18407.72388414175, 18461.630767384846, 18494.722579161324, 18508.259669613333, 581313.0, 584780.0, 585858.0, 586601.0, 588325.0, 63555.36444635587, 64241.35758642447, 64244.357556423834, 64284.67857660682, 64315.67842160759, 1320.6896379350844, 1358.334416136106, 1409.0629731228619, 1418.2554159066572, 1448.4351103069812, 30740.846295769272, 34836.65163348334, 35416.114597135274, 35752.463713043806, 35760.0, 55457.0, 55641.7217913924, 55873.161902572305, 56119.71940140273, 56445.71777141252, 407157.0, 407515.0, 408219.0, 408648.0, 409055.0, 28723.712762872103, 29668.258293542833, 31129.0, 32150.51774223435, 32359.51460728138, 50871.23693144532, 51035.74482127566, 51056.23415648694, 51403.0, 52418.73790631023, 43175.784121079196, 43744.78127609342, 44841.103177935605, 45144.54855451403, 45851.541484584726, 45182.54817451915, 45830.31254531118, 45933.540664592925, 46069.30896036629, 46213.53786462227, 44191.0, 44602.330965034904, 44728.0, 44973.32540011968, 45178.77410612926, 37753.0, 39510.80244598759, 39927.80036099801, 40227.59772402239, 40475.59524404836, 29744.02559744095, 29802.0, 30117.247068823453, 30124.698753012188, 30248.84875575608], "value": 21820.558139611054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.56954489151735, 412.46997608073633, 418.6169654765889, 420.2121023081723, 425.6297021591214, 18744.812551874493, 20323.49191270217, 20567.0, 20962.580748385022, 21223.151073957062, 19629.803701962977, 19809.20763169475, 20027.799722002776, 20485.07817148228, 20813.375598732026, 5823.82528524145, 6078.756849726005, 6079.1793107930525, 6086.269647642289, 6086.665233412161, 5709.8287051388315, 5833.737481813308, 5872.442117998805, 5954.732037058343, 6036.577439579231, 5841.766329346821, 5843.64938103713, 5844.26946631671, 5844.357120716718, 5845.09401042839, 5628.718564071801, 5828.242328497289, 5833.766649334021, 5860.150278209636, 5893.322267939199, 5298.2052692096495, 5304.336957880265, 5320.76056577455, 5325.653832500875, 5325.653832500914, 23772.76227237723, 23938.401539961465, 24005.639915401283, 24046.158384456634, 24073.0, 2445.7431969643108, 2506.2105436787538, 2508.611165269386, 2557.9872100639564, 2675.779103344239, 14660.193689347081, 14908.62728431787, 14929.701405971928, 15079.47221847241, 15364.0, 2014.2849288502664, 2015.617032763785, 2062.3091264426434, 2153.4616345913523, 2161.8594791338514, 51570.22644660333, 75300.0, 84614.0, 85297.57351213266, 85860.57069714612, 10812.837807432894, 11200.999999999836, 11224.494897729459, 11596.594119205956, 11651.76696466066, 16359.754603680954, 16447.506574802774, 16462.176891155395, 16476.258568364454, 16490.17549122539, 8443.0, 8881.600327985256, 8996.550172491348, 9002.50486223264, 9045.095490451034, 8753.343499237455, 8815.779605509913, 8844.201193689865, 8862.0, 8983.0, 6959.164900212007, 7091.716331346688, 7121.323474269936, 7128.857422851514, 7150.713971441188, 2067.131804642054, 2114.4713821544615, 2118.089221634681, 2134.381029501458, 2153.8061574458375, 816.1797393619374, 929.0941332201049, 948.4735971535864, 1083.5828206140534, 1097.9066779323687, 20258.594828103356, 20341.694874576893, 20392.694109588367, 20466.38600841977, 20631.69052464214, 1031.0256807317014, 1065.7122576904349, 1066.328213225663, 1087.586717047517, 1112.6759156603616, 10924.836127458095, 11812.995895348991, 11898.524059037542, 11963.162578619413, 12032.217905836093, 508799.0, 510822.0, 514253.0, 514514.7097058038, 520634.0, 78035.0, 82344.58827705943, 90914.0, 93363.0, 99976.06510291994, 1038.2732087538752, 1046.6284469013542, 1092.2354351953663, 1093.753905371301, 1094.9781004379868, 17589.560260993065, 17728.46814595564, 17758.644827103126, 17771.0, 18417.53956151107, 40438.39342409925, 42851.78574107109, 43877.341839873065, 44172.779136104116, 44198.55801441945, 54994.0, 61040.38959610347, 62665.0, 62688.68655656693, 63256.36743632505, 8463.49219046859, 8490.278326342082, 8768.912310876809, 8927.375083744075, 9249.0, 13033.869661303266, 13268.93365533166, 13508.729825403241, 13645.249511276976, 13698.315084245947, 11035.44822758875, 11581.131415144066, 11655.76688466243, 11973.880261197277, 12095.516179352728, 11620.070394368262, 11801.114916381133, 11940.641780746591, 11966.940165299466, 12129.332886691316, 11426.885731142582, 11616.186866919235, 11806.645800625995, 12181.817272741093, 12227.572034978733, 8925.018247992586, 8961.686340978034, 9169.266458683423, 9252.95373523128, 9412.623495060121, 9359.438433694, 11734.119941004288, 11853.407329633656, 11988.880111198776, 12571.1200215984], "value": 9755.252951504215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.0495672855914, 1515.0606623893186, 1638.9754153687697, 1815.1922394534422, 1823.7082066869295, 8635.78410539736, 9305.674301399453, 9307.0, 9309.99999999999, 9312.441253524794, 8063.0, 8246.587670616474, 8647.0488246293, 8843.292536597073, 9134.223590994774, 2610.8955641774305, 2637.5516162252366, 2640.815142939995, 2641.300055485298, 2647.4440367522843, 2523.873806309677, 2571.922842314724, 2581.7031041430196, 2582.0575489946127, 2583.173384516955, 2579.6259542366347, 2582.3415029167536, 2600.93497662559, 2613.3858543242322, 2615.4115324052127, 2516.8615726134963, 2525.330787341356, 2527.8356906801, 2543.351445381416, 2551.783098436635, 2514.7736703696573, 2523.558377283968, 2531.5696331623667, 2562.897484100634, 2567.1271767599105, 9304.395214311047, 9498.762530936781, 9510.90489095114, 9516.23870090391, 9527.428354298765, 5629.0, 5719.370869204384, 5755.0, 5787.594868359217, 5790.218320526717, 3652.1600031992525, 3738.140227747633, 3789.696824254053, 3808.371618682914, 3819.4079917612817, 1181.7636472705494, 1238.3591740943286, 1253.9059570532247, 1255.039894480723, 1276.2278821313064, 12336.0, 12492.81260781089, 12508.249505029728, 12523.499060037588, 12535.874641253562, 5072.847814565569, 5191.169412893994, 5224.947750522522, 5246.31797866275, 5253.711045892513, 10634.41510716918, 10639.202059845542, 10639.574417023387, 10643.0, 10650.840237396445, 5808.796692115756, 5838.970805146032, 5839.124131380327, 5853.765849365977, 5857.4435428634215, 4529.252673308933, 4632.652551058684, 4981.750912454363, 5004.049230646166, 5353.0, 4340.0, 4380.342948557742, 4401.097774956126, 4481.193385190697, 4487.573680500347, 1424.7008128292966, 1435.103060587133, 1457.6137323609253, 1462.722082804264, 1464.736347457468, 930.297625292913, 976.770458942148, 1013.3970287678819, 1020.403064207447, 1028.228828378716, 5873.009530279091, 5947.732352044169, 6072.423119803611, 6131.50947924165, 6183.134361189437, 471.05318310196066, 472.4967909176716, 476.04077783266746, 506.68585477004495, 511.51406164144214, 4093.1199792044854, 4283.20760659279, 4304.988327742978, 4321.762303073361, 4388.05656783793, 10990.560377584807, 11229.943850280697, 11326.433678316216, 11334.263272887236, 11336.43317834105, 11156.386398747984, 11212.719682008015, 11238.887611123784, 11250.268732532522, 11256.493457794419, 8087.393445491612, 8361.331093512505, 8408.411411201158, 8430.747077587683, 8435.873461898076, 6241.96879015602, 6307.337729538516, 6336.873262534816, 6377.904331435125, 6391.808245752635, 10090.495475226357, 10516.474176291002, 10589.0, 10589.752046292724, 10594.523246453773, 10756.569737210737, 10807.243492955418, 10918.344899306067, 11326.32042077478, 11328.433578321215, 7418.295261950106, 7577.696892124253, 7901.091374491777, 8103.716369927024, 8205.220504052106, 8909.50997695107, 9395.06049395055, 9409.01205373426, 9411.43531388119, 9461.574229159842, 7957.721479748181, 8033.758987230392, 8459.534725590152, 8504.659813607386, 8645.092265312303, 8149.674013039412, 8187.181281871765, 8264.917350826414, 8300.335973122257, 8361.95819020901, 7172.246914074156, 7386.0, 7451.068616422947, 7461.701531938662, 7526.209747976603, 5077.543021128116, 5189.4032186299055, 5332.866678333073, 5344.11822049373, 5413.323334583177, 5354.0, 5539.446055394428, 5622.803201887914, 5673.74468148926, 5803.535717142703], "value": 4853.588467122371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8837618457355, 344.6742828027515, 348.55385107062966, 354.3939862834554, 356.7823627587171, 5553.694546799924, 5603.215549823028, 5621.550275977922, 5631.887362252753, 5662.839117980814, 5527.39198688144, 5563.749631266593, 5567.693776842272, 5575.2473416088815, 5584.888302233963, 4192.517860446042, 4408.97795511022, 4411.720601025707, 4414.492333381654, 4426.933595996063, 3935.60643935607, 4278.251306021434, 4284.614384705376, 4376.752625501733, 4385.10105428388, 4369.0, 4375.037491751809, 4376.781160941956, 4383.312424716475, 4386.144701783153, 4400.669949753781, 4402.955970440286, 4404.744647775385, 4408.40486534317, 4415.66882483815, 3870.283997460451, 3905.2775236581324, 3912.8043597819997, 3939.9606003940166, 3958.148997965451, 5388.407275199725, 5390.649607775521, 5403.891922161574, 5408.242846001563, 5409.512384094405, 5025.773840177201, 5051.696898186084, 5059.772310246011, 5062.1141300272675, 5087.821926232564, 5614.466625670555, 5760.452756988121, 5810.356287889001, 5813.186153938452, 5827.825165245049, 4288.485381754178, 4298.957010429887, 4299.74201547905, 4308.569143085698, 4340.826366945318, 5685.640459209423, 5878.353381128115, 6111.938880611226, 6134.0, 6149.938500615026, 4295.420118284054, 4387.27609944362, 4433.578810013044, 4440.222960981815, 4440.555944405533, 4504.076664283814, 4510.684252102387, 4541.864533866534, 4550.408446901882, 4559.472576686847, 4874.0, 5083.474957512805, 5084.694918304914, 5086.109930762102, 5120.48795120485, 5773.509251713567, 5802.839432113594, 5814.883702325929, 5823.82528524145, 5938.524918006549, 1522.8781697464176, 1545.3509525999107, 1547.2418514927604, 1552.9595171235073, 1561.149173700336, 960.70698436976, 1011.9797604047877, 1013.8290274732695, 1018.7911478146962, 1033.9534720937577, 4990.800367985313, 4991.575716064175, 5008.622628777042, 5010.549050585465, 5033.270175824485, 5180.922286165711, 5196.246544251062, 5212.7914883405, 5259.211867964834, 5263.473652634706, 4940.382452193476, 5020.422651395063, 5024.62315326352, 5378.757955891994, 5791.797287094932, 3178.9509461877524, 3189.7767156298837, 3191.824449655291, 3203.8718451262152, 3210.807351558914, 6064.151018857364, 6210.50315974721, 6235.469985051322, 6246.187995560639, 6277.497800175975, 6089.208402907682, 6115.6330620162935, 6131.294901086343, 6172.69136543171, 6185.907211391833, 6106.832074613537, 6147.200863887666, 6152.16945712332, 6158.230221222348, 6162.476189523851, 5856.121581762599, 5962.284525856925, 5998.400159983967, 6026.789062382795, 6123.2652081750475, 5942.0, 5950.9702451487465, 5952.821415357546, 5957.642541447353, 5980.312264089685, 6003.129546215861, 6032.1856549365275, 6131.693415329127, 6181.5363847710705, 6194.690265486617, 4313.331433627793, 4331.675124365622, 4334.32817913224, 4334.591257841151, 4335.263005289045, 5861.472467477947, 6043.607165534227, 6046.30467496226, 6062.363451837494, 6080.391960803884, 5829.735348205018, 5832.416758324133, 5849.210356601804, 5862.361937128395, 5877.4122587740885, 5808.680522571299, 5819.330776960534, 5870.559708022, 5876.676782776988, 5906.320773111147, 5695.572832037697, 5768.946158475829, 5802.6808525531505, 5823.4176582343125, 5856.443637854397, 5863.185670878088, 5867.237259156454, 5874.471297583238, 5879.824035192893, 5882.205902203148, 5538.978272930432, 5743.195952566561, 5780.508656764222, 5804.791526143512, 5806.01297779387], "value": 4450.201572092134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.684743221292, 847.8897743293375, 880.929525637949, 882.9867551986721, 917.0685429678236, 16944.23750931208, 18119.275228990857, 18189.545261368472, 18239.452816415513, 18248.45254642361, 15059.0, 15131.773023404658, 16379.754303685455, 17172.656546869086, 17254.56863578408, 735.33819562394, 756.092688773474, 857.4812238595654, 879.5382424227267, 884.5621417398364, 855.179028132993, 865.4417900454204, 880.9911900880974, 882.3162049411725, 883.3551507399602, 913.447364344572, 913.8492148795441, 915.0254978447931, 919.3013309884502, 919.9034101419355, 910.1171863292595, 913.2739472119614, 913.5660561233394, 913.7761248494128, 914.6158613382395, 672.4317951331118, 672.492268337407, 673.323310073378, 673.7237732529688, 673.8854394752904, 15668.608284792857, 15820.920895395564, 15827.0, 15840.76238856418, 15902.204889755581, 15517.301721422451, 15681.764773528406, 15694.686106277924, 16261.0, 16360.83639163605, 13177.604671859859, 13875.306234688325, 13921.860781392157, 14031.43874245029, 14239.359228834728, 4168.749875007509, 4178.623923846838, 4219.135077309144, 4278.850240241577, 4290.785460726951, 89500.55249723775, 89681.55159224228, 90021.0, 90438.0, 90749.54625226898, 12399.75200495985, 12851.293178875065, 12880.484780608858, 12921.483140674456, 13005.674858128434, 23890.52218955611, 23988.760112399003, 24032.279031629078, 24041.759582403953, 24103.15638952628, 9138.588763505659, 9207.309451791009, 9332.300077494216, 9416.293777966679, 9420.528973551294, 4963.206903251882, 5192.636515443883, 5234.528892399626, 5309.469053094737, 5325.680459172462, 3996.800159991989, 4160.375943608423, 4165.937510937339, 4166.541680415152, 4177.832886684499, 688.9862202755917, 693.1924308181013, 695.0547255732301, 698.5354739098544, 720.771085299563, 775.3719487215374, 787.2993036197788, 792.5086446403267, 796.0964305513285, 814.4339683919619, 10232.567440558329, 10576.947115264375, 10713.303635263683, 11323.43382830855, 11418.143639227092, 681.9727210911508, 759.4038679636569, 776.5573623034816, 781.5440695762363, 781.7498400511895, 4931.4821943696115, 5209.426963034063, 5266.47335266478, 5379.488948549882, 5409.188621706697, 99599.0, 128324.35837820751, 129513.0, 129591.0, 130511.0, 105532.47233763782, 107477.0, 108433.0, 108670.45664771783, 109039.45480272548, 76732.23267767363, 77444.61277693576, 80252.19747802564, 84030.57984709916, 93357.53321233351, 10129.613554045642, 10200.846987295345, 10241.283110182216, 10286.794264114826, 10471.842922356323, 56250.74997000074, 56264.718676407996, 57494.42505574891, 58041.41958580529, 58496.0, 73546.0, 75564.0, 75812.62093689496, 76607.0, 79100.0, 13893.667973960213, 13933.258342707162, 14453.927730361282, 14491.130532168103, 14693.265336733335, 14706.77939830882, 14919.104853708812, 14954.40182392692, 14960.551183464513, 15152.242387880342, 14086.436542538593, 14178.787318190442, 14490.0, 14642.0, 14865.0, 14818.851811482178, 15116.773248401503, 16139.354425823305, 16191.433299834449, 16327.346906124098, 14724.779128313297, 15046.247687615356, 15069.924650376677, 15919.920400397923, 16294.429694961094, 11653.6503904883, 12316.753664926831, 12328.876711232773, 12635.74728505443, 12708.237505749685, 12230.388480575757, 12242.387880605756, 12281.201721888048, 12465.563705270271, 12509.43707533145], "value": 8281.988406179269, "unit": "score"}], "name": "dromaeo_css", "value": 7729.7035406089135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 109.0, 112.0, 108.0, 109.0, 109.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 114.0, 152.0, 118.0, 120.0, 120.0, 124.0, 147.0, 120.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 159.0, 159.0, 160.0, 158.0, 160.0, 160.0, 158.0], "value": 159.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 77.0, 76.0, 79.0, 76.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 131.0, 81.0, 81.0, 82.0, 105.0, 82.0, 82.0, 112.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 49.0, 52.0, 49.0, 51.0, 49.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 60.0, 61.0, 58.0, 59.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 74.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 119.0, 121.0, 122.0, 119.0, 129.0, 122.0, 159.0, 122.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 152.0, 153.0, 152.0, 153.0, 157.0, 152.0, 151.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 63.0, 63.0, 61.0, 62.0, 60.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1450.4, "alertThreshold": 2.0}]} 06:09:29 INFO - Return code: 0 06:09:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:29 INFO - # TBPL SUCCESS # 06:09:29 INFO - Running post-action listener: _resource_record_post_action 06:09:29 INFO - [mozharness: 2016-11-24 14:09:29.421132Z] Finished run-tests step (success) 06:09:29 INFO - Running post-run listener: _resource_record_post_run 06:09:29 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 309751808; Read time: 40; Write time: 177828 06:09:29 INFO - TinderboxPrint: CPU usage
12.9% 06:09:29 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 40 06:09:29 INFO - TinderboxPrint: I/O write bytes / time
309,751,808 / 177,828 06:09:29 INFO - TinderboxPrint: CPU idle
8,242.5 (87.0%) 06:09:29 INFO - TinderboxPrint: CPU user
1,183.7 (12.5%) 06:09:29 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:29 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 94846976; Read time: 0; Write time: 69796 06:09:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209346560; Read time: 16; Write time: 107536 06:09:30 INFO - Running post-run listener: _upload_blobber_files 06:09:30 INFO - Blob upload gear active. 06:09:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:33 INFO - (blobuploader) - INFO - Done attempting. 06:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:34 INFO - (blobuploader) - INFO - Done attempting. 06:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:35 INFO - (blobuploader) - INFO - Done attempting. 06:09:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:35 INFO - Return code: 0 06:09:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80b2cfc0b72e7e1399d4ee990f252a1ef29a26b3c5c72f92869aa320f2905e60292577a3c9d31efe9f2982e2e6e15bdef8b3aa637365a9a27c266942e16dd78f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b39c75913ef189e696a095ca3147654994fc91a877ca3376efb0b0164f663762e6435fed532ec51596d06f9216cd8de418dab864be57c8d3dae2e62b5293505f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd7f27ec2abe7bd815f218bea320da11d82074d7da9cbd31a96170e5aaea4302050c1dc52ac78de5af5f2002550e2cabdbca2e0f2d9e8490a43af0e48f2db4cb"} 06:09:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:35 INFO - Contents: 06:09:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80b2cfc0b72e7e1399d4ee990f252a1ef29a26b3c5c72f92869aa320f2905e60292577a3c9d31efe9f2982e2e6e15bdef8b3aa637365a9a27c266942e16dd78f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b39c75913ef189e696a095ca3147654994fc91a877ca3376efb0b0164f663762e6435fed532ec51596d06f9216cd8de418dab864be57c8d3dae2e62b5293505f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd7f27ec2abe7bd815f218bea320da11d82074d7da9cbd31a96170e5aaea4302050c1dc52ac78de5af5f2002550e2cabdbca2e0f2d9e8490a43af0e48f2db4cb"} 06:09:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:35 INFO - Copying logs to upload dir... 06:09:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.981504 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-24 06:09:35.378981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 06:09:35.382415) ========= 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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 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/80b2cfc0b72e7e1399d4ee990f252a1ef29a26b3c5c72f92869aa320f2905e60292577a3c9d31efe9f2982e2e6e15bdef8b3aa637365a9a27c266942e16dd78f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b39c75913ef189e696a095ca3147654994fc91a877ca3376efb0b0164f663762e6435fed532ec51596d06f9216cd8de418dab864be57c8d3dae2e62b5293505f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd7f27ec2abe7bd815f218bea320da11d82074d7da9cbd31a96170e5aaea4302050c1dc52ac78de5af5f2002550e2cabdbca2e0f2d9e8490a43af0e48f2db4cb"} build_url:https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011777 build_url: 'https://queue.taskcluster.net/v1/task/BXcOm5KNTy2o1nfWKZ59WA/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/80b2cfc0b72e7e1399d4ee990f252a1ef29a26b3c5c72f92869aa320f2905e60292577a3c9d31efe9f2982e2e6e15bdef8b3aa637365a9a27c266942e16dd78f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b39c75913ef189e696a095ca3147654994fc91a877ca3376efb0b0164f663762e6435fed532ec51596d06f9216cd8de418dab864be57c8d3dae2e62b5293505f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd7f27ec2abe7bd815f218bea320da11d82074d7da9cbd31a96170e5aaea4302050c1dc52ac78de5af5f2002550e2cabdbca2e0f2d9e8490a43af0e48f2db4cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 06:09:35.408624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:09:35.409014) ========= 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=1f5564757af27664ca02d71f000001b0-1479993958.406664-590479433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:09:35.496137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 06:09:35.496960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 06:09:35.497291) ========= ========= Total master_lag: 0.18 =========