builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1475014439.73 results: success (0) buildid: 20160927120422 builduid: f2fc5c85d23643dfb69d1e0a9dd5b1a8 revision: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.728399) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.728888) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.729225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.744234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.744537) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 15:14:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-09-27 15:14:00 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.881628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.882002) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018272 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.932162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:13:59.932539) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 15:14:00,420 truncating revision to first 12 chars 2016-09-27 15:14:00,420 Setting DEBUG logging. 2016-09-27 15:14:00,420 attempt 1/10 2016-09-27 15:14:00,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/515ab50a00a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 15:14:00,714 unpacking tar archive at: mozilla-aurora-515ab50a00a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:14:00.555852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 15:14:00.556622) ========= script_repo_revision: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 15:14:00.557648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 15:14:00.558475) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 15:14:00.569666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-27 15:14:00.569974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:01 INFO - MultiFileLogger online at 20160927 15:14:01 in /builds/slave/test 15:14:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:14:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:01 INFO - {'append_to_log': False, 15:14:01 INFO - 'base_work_dir': '/builds/slave/test', 15:14:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:14:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:01 INFO - 'branch': 'Mozilla-Aurora', 15:14:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:01 INFO - 'config_files': ('talos/linux_config.py',), 15:14:01 INFO - 'default_actions': ('clobber', 15:14:01 INFO - 'read-buildbot-config', 15:14:01 INFO - 'download-and-extract', 15:14:01 INFO - 'populate-webroot', 15:14:01 INFO - 'create-virtualenv', 15:14:01 INFO - 'install', 15:14:01 INFO - 'run-tests'), 15:14:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:01 INFO - 'download_minidump_stackwalk': True, 15:14:01 INFO - 'download_symbols': 'ondemand', 15:14:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:01 INFO - 'installer_path': 'installer.exe', 15:14:01 INFO - 'log_level': 'info', 15:14:01 INFO - 'log_name': 'talos', 15:14:01 INFO - 'log_to_console': True, 15:14:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:01 INFO - 'opt_config_files': (), 15:14:01 INFO - 'pip_index': False, 15:14:01 INFO - 'sps_profile': False, 15:14:01 INFO - 'sps_profile_interval': 0, 15:14:01 INFO - 'suite': 'dromaeojs', 15:14:01 INFO - 'system_bits': '32', 15:14:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:01 INFO - 'title': 'talos-linux64-ix-010', 15:14:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:01 INFO - 'use_talos_json': True, 15:14:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:01 INFO - 'work_dir': 'build'} 15:14:01 INFO - [mozharness: 2016-09-27 22:14:01.154519Z] Running clobber step. 15:14:01 INFO - Running pre-action listener: _resource_record_pre_action 15:14:01 INFO - Running main action method: clobber 15:14:01 INFO - rmtree: /builds/slave/test/build 15:14:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:02 INFO - Running post-action listener: _resource_record_post_action 15:14:02 INFO - [mozharness: 2016-09-27 22:14:02.175051Z] Finished clobber step (success) 15:14:02 INFO - [mozharness: 2016-09-27 22:14:02.175151Z] Running read-buildbot-config step. 15:14:02 INFO - Running pre-action listener: _resource_record_pre_action 15:14:02 INFO - Running main action method: read_buildbot_config 15:14:02 INFO - Using buildbot properties: 15:14:02 INFO - { 15:14:02 INFO - "project": "", 15:14:02 INFO - "product": "firefox", 15:14:02 INFO - "script_repo_revision": "production", 15:14:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:14:02 INFO - "repository": "", 15:14:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:14:02 INFO - "buildid": "20160927120422", 15:14:02 INFO - "pgo_build": "True", 15:14:02 INFO - "basedir": "/builds/slave/test", 15:14:02 INFO - "buildnumber": 488, 15:14:02 INFO - "slavename": "talos-linux64-ix-010", 15:14:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:14:02 INFO - "platform": "ubuntu64_hw", 15:14:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:14:02 INFO - "branch": "mozilla-aurora", 15:14:02 INFO - "repo_path": "releases/mozilla-aurora", 15:14:02 INFO - "revision": "515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b", 15:14:02 INFO - "stage_platform": "linux64-pgo", 15:14:02 INFO - "builduid": "f2fc5c85d23643dfb69d1e0a9dd5b1a8", 15:14:02 INFO - "slavebuilddir": "test" 15:14:02 INFO - } 15:14:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 15:14:02 INFO - Running post-action listener: _resource_record_post_action 15:14:02 INFO - [mozharness: 2016-09-27 22:14:02.177621Z] Finished read-buildbot-config step (success) 15:14:02 INFO - [mozharness: 2016-09-27 22:14:02.177711Z] Running download-and-extract step. 15:14:02 INFO - Running pre-action listener: _resource_record_pre_action 15:14:02 INFO - Running main action method: download_and_extract 15:14:02 INFO - mkdir: /builds/slave/test/build/tests 15:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:02 INFO - trying https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:14:02 INFO - Downloading https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:14:02 INFO - Downloaded 1361 bytes. 15:14:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:14:02 INFO - Using the following test package requirements: 15:14:02 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 15:14:02 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:14:02 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:14:02 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'jsshell-linux-x86_64.zip'], 15:14:02 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:14:02 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 15:14:02 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:14:02 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:14:02 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:14:02 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:14:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:14:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:14:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 15:14:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:02 INFO - Fetch https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:14:03 INFO - Expected file size: 21899376 15:14:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:14:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 15:14:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:14:08 INFO - Expected file size: 21899376 15:14:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 15:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:14:12 INFO - Fetch https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:14:13 INFO - Expected file size: 14414059 15:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:13 INFO - trying https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:14:15 INFO - Downloaded 63958212 bytes. 15:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:14:15 INFO - mkdir: /builds/slave/test/properties 15:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:14:15 INFO - Contents: 15:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:14:15 INFO - Running post-action listener: _resource_record_post_action 15:14:15 INFO - Running post-action listener: set_extra_try_arguments 15:14:15 INFO - [mozharness: 2016-09-27 22:14:15.820520Z] Finished download-and-extract step (success) 15:14:15 INFO - [mozharness: 2016-09-27 22:14:15.820747Z] Running populate-webroot step. 15:14:15 INFO - Running pre-action listener: _resource_record_pre_action 15:14:15 INFO - Running main action method: populate_webroot 15:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:15 INFO - '--tppagecycles', 15:14:15 INFO - '7'], 15:14:15 INFO - 'tests': ['tsvgm']}}, 15:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['damp', 'tps']}, 15:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'tests': ['damp', 'tps']}, 15:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['dromaeo_dom']}, 15:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['basic_compositor_video']}, 15:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['a11yr', 15:14:15 INFO - 'ts_paint', 15:14:15 INFO - 'tpaint', 15:14:15 INFO - 'sessionrestore', 15:14:15 INFO - 'sessionrestore_no_auto_restore', 15:14:15 INFO - 'tabpaint']}, 15:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['tsvgx', 15:14:15 INFO - 'tsvgr_opacity', 15:14:15 INFO - 'tart', 15:14:15 INFO - 'tscrollx', 15:14:15 INFO - 'cart']}, 15:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:14:15 INFO - 'tsvgr_opacity', 15:14:15 INFO - 'tart', 15:14:15 INFO - 'tscrollx', 15:14:15 INFO - 'cart']}, 15:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'talos_options': ['--disable-e10s'], 15:14:15 INFO - 'tests': ['tp5o']}, 15:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'tests': ['tp5o']}, 15:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'talos_options': ['--disable-e10s', 15:14:15 INFO - '--xperf_path', 15:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:15 INFO - 'tests': ['tp5n']}, 15:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:15 INFO - 'talos_options': ['--xperf_path', 15:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:15 INFO - 'tests': ['tp5n']}}, 15:14:15 INFO - 'talos.zip': {'path': '', 15:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:15 INFO - Running post-action listener: _resource_record_post_action 15:14:15 INFO - [mozharness: 2016-09-27 22:14:15.838555Z] Finished populate-webroot step (success) 15:14:15 INFO - [mozharness: 2016-09-27 22:14:15.838643Z] Running create-virtualenv step. 15:14:15 INFO - Running pre-action listener: _resource_record_pre_action 15:14:15 INFO - Running main action method: create_virtualenv 15:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:14:15 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 15:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:15 INFO - Using real prefix '/usr' 15:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:18 INFO - Installing pip.................done. 15:14:18 INFO - Return code: 0 15:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14:18 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')]} 15:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:18 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')]} 15:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:18 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:18 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 15:14:18 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 15:14:18 INFO - Using env: {'DISPLAY': ':0', 15:14:18 INFO - 'HOME': '/home/cltbld', 15:14:18 INFO - 'LANG': 'en_US.UTF-8', 15:14:18 INFO - 'LANGUAGE': 'en_US:en', 15:14:18 INFO - 'LOGNAME': 'cltbld', 15:14:18 INFO - 'MAIL': '/var/mail/cltbld', 15:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:18 INFO - 'MOZ_NO_REMOTE': '1', 15:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:18 INFO - 'NO_EM_RESTART': '1', 15:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:18 INFO - 'PWD': '/builds/slave/test', 15:14:18 INFO - 'SHELL': '/bin/bash', 15:14:18 INFO - 'SHLVL': '1', 15:14:18 INFO - 'TERM': 'linux', 15:14:18 INFO - 'TMOUT': '86400', 15:14:18 INFO - 'USER': 'cltbld', 15:14:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:18 INFO - '_': '/tools/buildbot/bin/python'} 15:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:18 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 15:14:18 INFO - Cleaning up... 15:14:18 INFO - Return code: 0 15:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:14:18 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')]} 15:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:18 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')]} 15:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:18 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:18 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 15:14:18 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 15:14:18 INFO - Using env: {'DISPLAY': ':0', 15:14:18 INFO - 'HOME': '/home/cltbld', 15:14:18 INFO - 'LANG': 'en_US.UTF-8', 15:14:18 INFO - 'LANGUAGE': 'en_US:en', 15:14:18 INFO - 'LOGNAME': 'cltbld', 15:14:18 INFO - 'MAIL': '/var/mail/cltbld', 15:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:18 INFO - 'MOZ_NO_REMOTE': '1', 15:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:18 INFO - 'NO_EM_RESTART': '1', 15:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:18 INFO - 'PWD': '/builds/slave/test', 15:14:18 INFO - 'SHELL': '/bin/bash', 15:14:18 INFO - 'SHLVL': '1', 15:14:18 INFO - 'TERM': 'linux', 15:14:18 INFO - 'TMOUT': '86400', 15:14:18 INFO - 'USER': 'cltbld', 15:14:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:18 INFO - '_': '/tools/buildbot/bin/python'} 15:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:18 INFO - Downloading/unpacking psutil>=3.1.1 15:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:20 INFO - Installing collected packages: psutil 15:14:20 INFO - Running setup.py install for psutil 15:14:20 INFO - building 'psutil._psutil_linux' extension 15:14:20 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 15:14:21 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 15:14:21 INFO - building 'psutil._psutil_posix' extension 15:14:21 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 15:14:21 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 15:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:21 INFO - Successfully installed psutil 15:14:21 INFO - Cleaning up... 15:14:21 INFO - Return code: 0 15:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:14:21 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')]} 15:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:21 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')]} 15:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:21 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:21 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 15:14:21 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 15:14:21 INFO - Using env: {'DISPLAY': ':0', 15:14:21 INFO - 'HOME': '/home/cltbld', 15:14:21 INFO - 'LANG': 'en_US.UTF-8', 15:14:21 INFO - 'LANGUAGE': 'en_US:en', 15:14:21 INFO - 'LOGNAME': 'cltbld', 15:14:21 INFO - 'MAIL': '/var/mail/cltbld', 15:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:21 INFO - 'MOZ_NO_REMOTE': '1', 15:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:21 INFO - 'NO_EM_RESTART': '1', 15:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:21 INFO - 'PWD': '/builds/slave/test', 15:14:21 INFO - 'SHELL': '/bin/bash', 15:14:21 INFO - 'SHLVL': '1', 15:14:21 INFO - 'TERM': 'linux', 15:14:21 INFO - 'TMOUT': '86400', 15:14:21 INFO - 'USER': 'cltbld', 15:14:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:21 INFO - '_': '/tools/buildbot/bin/python'} 15:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:14:23 INFO - Installing collected packages: mozsystemmonitor 15:14:23 INFO - Running setup.py install for mozsystemmonitor 15:14:23 INFO - Successfully installed mozsystemmonitor 15:14:23 INFO - Cleaning up... 15:14:23 INFO - Return code: 0 15:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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', '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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:14: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 jsonschema==2.5.1 15:14:23 INFO - Using env: {'DISPLAY': ':0', 15:14:23 INFO - 'HOME': '/home/cltbld', 15:14:23 INFO - 'LANG': 'en_US.UTF-8', 15:14:23 INFO - 'LANGUAGE': 'en_US:en', 15:14:23 INFO - 'LOGNAME': 'cltbld', 15:14:23 INFO - 'MAIL': '/var/mail/cltbld', 15:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:23 INFO - 'MOZ_NO_REMOTE': '1', 15:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:23 INFO - 'NO_EM_RESTART': '1', 15:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:23 INFO - 'PWD': '/builds/slave/test', 15:14:23 INFO - 'SHELL': '/bin/bash', 15:14:23 INFO - 'SHLVL': '1', 15:14:23 INFO - 'TERM': 'linux', 15:14:23 INFO - 'TMOUT': '86400', 15:14:23 INFO - 'USER': 'cltbld', 15:14:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:23 INFO - '_': '/tools/buildbot/bin/python'} 15:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:26 INFO - warning: no files found matching '*.txt' 15:14:26 INFO - no previously-included directories found matching 'build' 15:14:26 INFO - no previously-included directories found matching 'dist' 15:14:26 INFO - no previously-included directories found matching '.git*' 15:14:26 INFO - Installing collected packages: jsonschema, functools32 15:14:26 INFO - Running setup.py install for functools32 15:14:26 INFO - warning: no files found matching '*.txt' 15:14:26 INFO - no previously-included directories found matching 'build' 15:14:26 INFO - no previously-included directories found matching 'dist' 15:14:26 INFO - no previously-included directories found matching '.git*' 15:14:26 INFO - Successfully installed jsonschema functools32 15:14:26 INFO - Cleaning up... 15:14:26 INFO - Return code: 0 15:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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', '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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:14: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 functools32==3.2.3-2 15:14:26 INFO - Using env: {'DISPLAY': ':0', 15:14:26 INFO - 'HOME': '/home/cltbld', 15:14:26 INFO - 'LANG': 'en_US.UTF-8', 15:14:26 INFO - 'LANGUAGE': 'en_US:en', 15:14:26 INFO - 'LOGNAME': 'cltbld', 15:14:26 INFO - 'MAIL': '/var/mail/cltbld', 15:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:26 INFO - 'MOZ_NO_REMOTE': '1', 15:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:26 INFO - 'NO_EM_RESTART': '1', 15:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:26 INFO - 'PWD': '/builds/slave/test', 15:14:26 INFO - 'SHELL': '/bin/bash', 15:14:26 INFO - 'SHLVL': '1', 15:14:26 INFO - 'TERM': 'linux', 15:14:26 INFO - 'TMOUT': '86400', 15:14:26 INFO - 'USER': 'cltbld', 15:14:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:26 INFO - '_': '/tools/buildbot/bin/python'} 15:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:14:26 INFO - Cleaning up... 15:14:26 INFO - Return code: 0 15:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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', '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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:14: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 blobuploader==1.2.4 15:14:26 INFO - Using env: {'DISPLAY': ':0', 15:14:26 INFO - 'HOME': '/home/cltbld', 15:14:26 INFO - 'LANG': 'en_US.UTF-8', 15:14:26 INFO - 'LANGUAGE': 'en_US:en', 15:14:26 INFO - 'LOGNAME': 'cltbld', 15:14:26 INFO - 'MAIL': '/var/mail/cltbld', 15:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:26 INFO - 'MOZ_NO_REMOTE': '1', 15:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:26 INFO - 'NO_EM_RESTART': '1', 15:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:26 INFO - 'PWD': '/builds/slave/test', 15:14:26 INFO - 'SHELL': '/bin/bash', 15:14:26 INFO - 'SHLVL': '1', 15:14:26 INFO - 'TERM': 'linux', 15:14:26 INFO - 'TMOUT': '86400', 15:14:26 INFO - 'USER': 'cltbld', 15:14:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:26 INFO - '_': '/tools/buildbot/bin/python'} 15:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:29 INFO - Downloading docopt-0.6.1.tar.gz 15:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:14:29 INFO - Running setup.py install for blobuploader 15:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:14:29 INFO - Running setup.py install for requests 15:14:29 INFO - Running setup.py install for docopt 15:14:29 INFO - Successfully installed blobuploader requests docopt 15:14:29 INFO - Cleaning up... 15:14:29 INFO - Return code: 0 15:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:29 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')]} 15:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:29 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')]} 15:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:29 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:29 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 15:14:29 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 15:14:29 INFO - Using env: {'DISPLAY': ':0', 15:14:29 INFO - 'HOME': '/home/cltbld', 15:14:29 INFO - 'LANG': 'en_US.UTF-8', 15:14:29 INFO - 'LANGUAGE': 'en_US:en', 15:14:29 INFO - 'LOGNAME': 'cltbld', 15:14:29 INFO - 'MAIL': '/var/mail/cltbld', 15:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:29 INFO - 'MOZ_NO_REMOTE': '1', 15:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:29 INFO - 'NO_EM_RESTART': '1', 15:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:29 INFO - 'PWD': '/builds/slave/test', 15:14:29 INFO - 'SHELL': '/bin/bash', 15:14:29 INFO - 'SHLVL': '1', 15:14:29 INFO - 'TERM': 'linux', 15:14:29 INFO - 'TMOUT': '86400', 15:14:29 INFO - 'USER': 'cltbld', 15:14:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:29 INFO - '_': '/tools/buildbot/bin/python'} 15:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:30 INFO - Running setup.py (path:/tmp/pip-xzK9DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:30 INFO - Running setup.py (path:/tmp/pip-lkIX8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:30 INFO - Running setup.py (path:/tmp/pip-pi9yOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:30 INFO - Running setup.py (path:/tmp/pip-o5awNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:30 INFO - Running setup.py (path:/tmp/pip-sdu3J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:30 INFO - Running setup.py (path:/tmp/pip-myh695-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:30 INFO - Running setup.py (path:/tmp/pip-0z8eoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:30 INFO - Running setup.py (path:/tmp/pip-mKXbB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:30 INFO - Running setup.py (path:/tmp/pip-TG3rha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:30 INFO - Running setup.py (path:/tmp/pip-KT7BF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:30 INFO - Running setup.py (path:/tmp/pip-IFH43N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:30 INFO - Running setup.py (path:/tmp/pip-Gawbsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:31 INFO - Running setup.py (path:/tmp/pip-UUAW9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:31 INFO - Running setup.py (path:/tmp/pip-j3oT3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:31 INFO - Running setup.py (path:/tmp/pip-Yd2C3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:31 INFO - Running setup.py (path:/tmp/pip-GlDreQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:31 INFO - Running setup.py (path:/tmp/pip-umAPQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:31 INFO - Running setup.py install for manifestparser 15:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:31 INFO - Running setup.py install for mozcrash 15:14:31 INFO - Running setup.py install for mozdebug 15:14:31 INFO - Running setup.py install for mozdevice 15:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:31 INFO - Running setup.py install for mozfile 15:14:31 INFO - Running setup.py install for mozhttpd 15:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:31 INFO - Running setup.py install for mozinfo 15:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for mozInstall 15:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for mozleak 15:14:32 INFO - Running setup.py install for mozlog 15:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for moznetwork 15:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for mozprocess 15:14:32 INFO - Running setup.py install for mozprofile 15:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for mozrunner 15:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:32 INFO - Running setup.py install for mozscreenshot 15:14:32 INFO - Running setup.py install for moztest 15:14:33 INFO - Running setup.py install for mozversion 15:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:33 INFO - Cleaning up... 15:14:33 INFO - Return code: 0 15:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:33 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')]} 15:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:33 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')]} 15:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:33 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:33 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 15:14:33 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 15:14:33 INFO - Using env: {'DISPLAY': ':0', 15:14:33 INFO - 'HOME': '/home/cltbld', 15:14:33 INFO - 'LANG': 'en_US.UTF-8', 15:14:33 INFO - 'LANGUAGE': 'en_US:en', 15:14:33 INFO - 'LOGNAME': 'cltbld', 15:14:33 INFO - 'MAIL': '/var/mail/cltbld', 15:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:33 INFO - 'MOZ_NO_REMOTE': '1', 15:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:33 INFO - 'NO_EM_RESTART': '1', 15:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:33 INFO - 'PWD': '/builds/slave/test', 15:14:33 INFO - 'SHELL': '/bin/bash', 15:14:33 INFO - 'SHLVL': '1', 15:14:33 INFO - 'TERM': 'linux', 15:14:33 INFO - 'TMOUT': '86400', 15:14:33 INFO - 'USER': 'cltbld', 15:14:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:33 INFO - '_': '/tools/buildbot/bin/python'} 15:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:33 INFO - Running setup.py (path:/tmp/pip-nmSvmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:33 INFO - Running setup.py (path:/tmp/pip-fAl0Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:33 INFO - Running setup.py (path:/tmp/pip-h1clTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:33 INFO - Running setup.py (path:/tmp/pip-AR2M3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:33 INFO - Running setup.py (path:/tmp/pip-bmEGjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:33 INFO - Running setup.py (path:/tmp/pip-xSvYqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:33 INFO - Running setup.py (path:/tmp/pip-UeEaAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:33 INFO - Running setup.py (path:/tmp/pip-dAbxi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:33 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)) 15:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:33 INFO - Running setup.py (path:/tmp/pip-zaJUM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:34 INFO - Running setup.py (path:/tmp/pip-GFP9bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:34 INFO - Running setup.py (path:/tmp/pip-fz3Ee0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:34 INFO - Running setup.py (path:/tmp/pip-tfpbi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:34 INFO - Running setup.py (path:/tmp/pip-sB2vNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:34 INFO - Running setup.py (path:/tmp/pip-BdH8AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:34 INFO - Running setup.py (path:/tmp/pip-uxn3dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:34 INFO - Running setup.py (path:/tmp/pip-jKhQs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:34 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)) 15:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:34 INFO - Running setup.py (path:/tmp/pip-ROABYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:34 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)) 15:14:34 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)) 15:14:34 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)) 15:14:34 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)) 15:14:34 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)) 15:14:34 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)) 15:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:36 INFO - Downloading blessings-1.6.tar.gz 15:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:36 INFO - Installing collected packages: blessings 15:14:36 INFO - Running setup.py install for blessings 15:14:36 INFO - Successfully installed blessings 15:14:36 INFO - Cleaning up... 15:14:36 INFO - Return code: 0 15:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:36 INFO - Reading from file tmpfile_stdout 15:14:36 INFO - Current package versions: 15:14:36 INFO - argparse == 1.2.1 15:14:36 INFO - blessings == 1.6 15:14:36 INFO - blobuploader == 1.2.4 15:14:36 INFO - docopt == 0.6.1 15:14:36 INFO - functools32 == 3.2.3-2 15:14:36 INFO - jsonschema == 2.5.1 15:14:36 INFO - manifestparser == 1.1 15:14:36 INFO - mozInstall == 1.12 15:14:36 INFO - mozcrash == 0.17 15:14:36 INFO - mozdebug == 0.1 15:14:36 INFO - mozdevice == 0.48 15:14:36 INFO - mozfile == 1.2 15:14:36 INFO - mozhttpd == 0.7 15:14:36 INFO - mozinfo == 0.9 15:14:36 INFO - mozleak == 0.1 15:14:36 INFO - mozlog == 3.4 15:14:36 INFO - moznetwork == 0.27 15:14:36 INFO - mozprocess == 0.23 15:14:36 INFO - mozprofile == 0.28 15:14:37 INFO - mozrunner == 6.12 15:14:37 INFO - mozscreenshot == 0.1 15:14:37 INFO - mozsystemmonitor == 0.3 15:14:37 INFO - moztest == 0.7 15:14:37 INFO - mozversion == 1.4 15:14:37 INFO - psutil == 3.1.1 15:14:37 INFO - requests == 1.2.3 15:14:37 INFO - wsgiref == 0.1.2 15:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:37 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')]} 15:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 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')]} 15:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:37 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 15:14:37 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 15:14:37 INFO - Using env: {'DISPLAY': ':0', 15:14:37 INFO - 'HOME': '/home/cltbld', 15:14:37 INFO - 'LANG': 'en_US.UTF-8', 15:14:37 INFO - 'LANGUAGE': 'en_US:en', 15:14:37 INFO - 'LOGNAME': 'cltbld', 15:14:37 INFO - 'MAIL': '/var/mail/cltbld', 15:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:37 INFO - 'MOZ_NO_REMOTE': '1', 15:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:37 INFO - 'NO_EM_RESTART': '1', 15:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:37 INFO - 'PWD': '/builds/slave/test', 15:14:37 INFO - 'SHELL': '/bin/bash', 15:14:37 INFO - 'SHLVL': '1', 15:14:37 INFO - 'TERM': 'linux', 15:14:37 INFO - 'TMOUT': '86400', 15:14:37 INFO - 'USER': 'cltbld', 15:14:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:37 INFO - '_': '/tools/buildbot/bin/python'} 15:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 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)) 15:14:37 INFO - Cleaning up... 15:14:37 INFO - Return code: 0 15:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14:37 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')]} 15:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 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')]} 15:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 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 0x7fce5d4c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', '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 15:14:37 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 15:14:37 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 15:14:37 INFO - Using env: {'DISPLAY': ':0', 15:14:37 INFO - 'HOME': '/home/cltbld', 15:14:37 INFO - 'LANG': 'en_US.UTF-8', 15:14:37 INFO - 'LANGUAGE': 'en_US:en', 15:14:37 INFO - 'LOGNAME': 'cltbld', 15:14:37 INFO - 'MAIL': '/var/mail/cltbld', 15:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:37 INFO - 'MOZ_NO_REMOTE': '1', 15:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:37 INFO - 'NO_EM_RESTART': '1', 15:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:37 INFO - 'PWD': '/builds/slave/test', 15:14:37 INFO - 'SHELL': '/bin/bash', 15:14:37 INFO - 'SHLVL': '1', 15:14:37 INFO - 'TERM': 'linux', 15:14:37 INFO - 'TMOUT': '86400', 15:14:37 INFO - 'USER': 'cltbld', 15:14:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:37 INFO - '_': '/tools/buildbot/bin/python'} 15:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:14:37 INFO - Cleaning up... 15:14:37 INFO - Return code: 0 15:14:37 INFO - Running post-action listener: _resource_record_post_action 15:14:37 INFO - Running post-action listener: _start_resource_monitoring 15:14:37 INFO - Starting resource monitoring. 15:14:37 INFO - [mozharness: 2016-09-27 22:14:37.495575Z] Finished create-virtualenv step (success) 15:14:37 INFO - [mozharness: 2016-09-27 22:14:37.496122Z] Running install step. 15:14:37 INFO - Running pre-action listener: _resource_record_pre_action 15:14:37 INFO - Running main action method: install 15:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:37 INFO - Reading from file tmpfile_stdout 15:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:37 INFO - Reading from file tmpfile_stdout 15:14:37 INFO - Output received: 15:14:37 INFO - Usage: mozinstall [options] installer 15:14:37 INFO - Options: 15:14:37 INFO - -h, --help show this help message and exit 15:14:37 INFO - -d DEST, --destination=DEST 15:14:37 INFO - Directory to install application into. [default: 15:14:37 INFO - "/builds/slave/test"] 15:14:37 INFO - --app=APP Application being installed. [default: firefox] 15:14:37 INFO - mkdir: /builds/slave/test/build/application 15:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:14:53 INFO - Reading from file tmpfile_stdout 15:14:53 INFO - Output received: 15:14:53 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:53 INFO - Running post-action listener: _resource_record_post_action 15:14:53 INFO - [mozharness: 2016-09-27 22:14:53.824028Z] Finished install step (success) 15:14:53 INFO - [mozharness: 2016-09-27 22:14:53.824271Z] Running run-tests step. 15:14:53 INFO - Running pre-action listener: _resource_record_pre_action 15:14:53 INFO - Running main action method: run_tests 15:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:53 INFO - Python 2.7.3 15:14:53 INFO - Return code: 0 15:14:53 INFO - grabbing minidump binary from tooltool 15:14:53 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')]} 15:14:53 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 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:53 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 15:14:53 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 15:14:53 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 15:14:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:53 INFO - Return code: 0 15:14:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:14:53 INFO - Using env: {'DISPLAY': ':0', 15:14:53 INFO - 'HOME': '/home/cltbld', 15:14:53 INFO - 'LANG': 'en_US.UTF-8', 15:14:53 INFO - 'LANGUAGE': 'en_US:en', 15:14:53 INFO - 'LOGNAME': 'cltbld', 15:14:53 INFO - 'MAIL': '/var/mail/cltbld', 15:14:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:53 INFO - 'MOZ_NO_REMOTE': '1', 15:14:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:53 INFO - 'NO_EM_RESTART': '1', 15:14:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:53 INFO - 'PWD': '/builds/slave/test', 15:14:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:53 INFO - 'SHELL': '/bin/bash', 15:14:53 INFO - 'SHLVL': '1', 15:14:53 INFO - 'TERM': 'linux', 15:14:53 INFO - 'TMOUT': '86400', 15:14:53 INFO - 'USER': 'cltbld', 15:14:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756', 15:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:53 INFO - '_': '/tools/buildbot/bin/python'} 15:14:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:14:54 INFO - mozversion application_buildid: 20160927120422 15:14:54 INFO - mozversion application_changeset: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b 15:14:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:14:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:54 INFO - mozversion application_name: Firefox 15:14:54 INFO - mozversion application_remotingname: firefox-dev 15:14:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:14:54 INFO - mozversion application_vendor: Mozilla 15:14:54 INFO - mozversion application_version: 51.0a2 15:14:54 INFO - mozversion platform_buildid: 20160927120422 15:14:54 INFO - mozversion platform_changeset: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b 15:14:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:14:54 INFO - mozversion platform_version: 51.0a2 15:14:54 INFO - using testdate: 1475014494 15:14:54 INFO - actual date: 1475014494 15:14:54 INFO - starting webserver on 'localhost:45043' 15:14:54 INFO - SUITE-START | Running 2 tests 15:14:54 INFO - TEST-START | dromaeo_css 15:14:54 INFO - operating with platform_type : linux_ 15:14:54 INFO - Initialising browser for dromaeo_css test... 15:14:54 INFO - TEST-INFO | started process 20304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHdCQRk/profile http://localhost:45043/getInfo.html) 15:14:58 INFO - PROCESS | 20304 | __metrics Screen width/height:1600/1200 15:14:58 INFO - PROCESS | 20304 | colorDepth:24 15:14:58 INFO - PROCESS | 20304 | Browser inner width/height: 1024/697 15:14:58 INFO - PROCESS | 20304 | __metrics 15:14:59 INFO - PROCESS | 20304 | 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" 15:14:59 INFO - PROCESS | 20304 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:14:59 INFO - PROCESS | 20304 | console.error: PushService: 15:14:59 INFO - PROCESS | 20304 | stateChangeProcessEnqueue: Error transitioning state 15:14:59 INFO - PROCESS | 20304 | UnknownError 15:15:00 INFO - TEST-INFO | 20304: exit 0 15:15:00 INFO - Browser initialized. 15:15:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:00 INFO - TEST-INFO | started process 20392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHdCQRk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:12 INFO - PROCESS | 20392 | RSS: Main: 144064512 15:15:12 INFO - PROCESS | 20392 | 15:16:03 INFO - PROCESS | 20392 | 1475014563169 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] 15:18:12 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45043/tests/dromaeo/cssquery-ext.html) 15:18:13 INFO - PROCESS | 20392 | RSS: Main: 244842496 15:18:13 INFO - PROCESS | 20392 | 15:21:16 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-ext.html (next: http://localhost:45043/tests/dromaeo/cssquery-jquery.html) 15:21:16 INFO - PROCESS | 20392 | RSS: Main: 237613056 15:21:16 INFO - PROCESS | 20392 | 15:24:18 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45043/tests/dromaeo/cssquery-mootools.html) 15:24:19 INFO - PROCESS | 20392 | RSS: Main: 175972352 15:24:19 INFO - PROCESS | 20392 | 15:27:21 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45043/tests/dromaeo/cssquery-prototype.html) 15:27:21 INFO - PROCESS | 20392 | RSS: Main: 226013184 15:27:21 INFO - PROCESS | 20392 | 15:30:24 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45043/tests/dromaeo/cssquery-yui.html) 15:30:24 INFO - PROCESS | 20392 | RSS: Main: 177987584 15:30:24 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | Cycle 1(1): loaded http://localhost:45043/tests/dromaeo/cssquery-yui.html (next: http://localhost:45043/tests/dromaeo/cssquery-dojo.html) 15:33:27 INFO - PROCESS | 20392 | RSS: Main: 261582848 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | __start_tp_report 15:33:27 INFO - PROCESS | 20392 | _x_x_mozilla_page_load 15:33:27 INFO - PROCESS | 20392 | _x_x_mozilla_page_load_details 15:33:27 INFO - PROCESS | 20392 | |i|pagename|runs| 15:33:27 INFO - PROCESS | 20392 | |0;dojo.html;3148.2444213388785;3181.0774875286174;3196.504541796021;3214;3229.9677003229963;5697.971510142449;5746.0806270996645;5784.797532086378;5800.53595712343;5817.243758311419;5706.686132262724;5775.768969241225;5785.5082318002915;5792.218050563172;5796.768129274835;5264.578833693296;5265.289185959894;5289.18017707256;5307.628466007381;5357.035733567956;5177.663451875635;5359.222912677659;5371.677699338053;5373.838784836442;5390.353157621072;5143.871403214912;5220.504052115043;5232.45059268777;5284;5293.550048245904;5226.660267082647;5247.370315562119;5255;5363.597730170214;5364.597655175839;5185.766640501187;5212.50481204285;5282.550983166436;5297;5311.336082989626;5481.314835645544;5526.226328314039;5572.3870374258795;5625.268715067056;5670.773169073233;5995.130706047598;6008.36912124225;6017.548683848729;6106.084087386927;6110.725017374184;6144.539159563051;6145.784897528565;6155.907661385083;6155.907661385083;6158.784442544489;5647.971760141214;5660.094384898479;5692.829215123553;5708.172315014342;5715.599908006483;6315.305316415191;6346.746130154742;6348.555601107878;6350.237971443364;6353.4599559038;6091.786787462417;6092.695365231721;6094.603850749687;6094.695265236721;6099.268087829489;5918.556108291896;5950.5239580834295;6124.6325220486915;6135.845176233341;6159.23009623797;6214.471769899519;6215.440610345;6215.533834962396;6219.067139929047;6227.06594010893;6150;6171.858206231862;6221.160143380676;6227.816714824169;6230.7507699691505;4610.4467463903875;4666.556677115668;4673.929891051569;4757.215059515211;4784.617230621542;4160.417541544186;4163.167366526707;4169.45797046382;4205.411242426063;4215.178040282177;5822.650640961556;5865.589766798731;5866.442687944724;5871.9706401468575;5905.616134951214;5921.911171332434;5984.850378740566;6198.380161983856;6199.845003874939;6209.5032397408095;5807.157962095473;5888.499477544457;5905.498032667186;5953.672548009815;5992.550558708027;5358.946410535923;5385.515303622693;5397.676139431646;5403.162509810985;5411.2965314508865;6037.18498002764;6415.711292991827;6451.580647257913;6484.189476315555;6499.382558657015;5957.3446920837805;6083.239595050619;6133.969330153321;6149.385061493994;6241.812745617639;6308.990561510136;6313.305536390902;6313.558050936574;6320.905186422299;6389.520785941166;5856.736446859987;6106.755729770759;6114.602550834182;6128.050152226412;6133.080037994337;6000.489958353414;6066.636001839727;6073.271207455134;6133.877322453615;6189.721462534107;5993.61041532299;6003.279606447254;6014.789482368096;6018.578699491169;6018.699065046642;6006.819795406145;6015.6691381974415;6016.5487588431915;6027.126066720389;6040.0939859019745;5767.8558036049435;5780.5953583248765;5836.941630583639;5852.473277405054;5919.85200369977;6028.216331876828;6037.245344331958;6041.909371359521;6049.092636104443;6051.273847138372;5773.134029895549;5902.61632993854;5907.202527658883;5911.3201981772645;5912.852178695567 15:33:27 INFO - PROCESS | 20392 | |1;ext.html;590.2356448399322;621.9720112594932;630.3412933484508;649.1463725201357;650.1775254303305;37287.81356093219;46992.295115573295;47775.28337074942;47835.28247076288;51695.48304516963;44633.330500042444;44972;45198.32202516957;45204.321935171;45351.31973020407;8523;9399.483028433433;9545.52272386378;9554.665586704466;9554.761130971747;8474.872876906851;11074.723131921686;11344.546218151265;11347.829782553268;11668.41657917105;11471.827922581168;11548.71128221797;11551.53793848245;11556.191066625339;11556.82664760025;11412.54349826006;11498.597549085825;11510.827337589943;11518.596849110241;11538.76922461546;11273.718157046058;11322.716932076682;11337.433128343633;11338.263012904135;11343.43282835855;47286;47600.761996190144;47615.76192119052;47620.28569571424;47663.76168119172;4009.1781184857327;4182.498100227962;4444.355568442557;4562.498125206224;4573.565511276423;31385;35910.102247444025;36384.272314553564;36572.26855462902;36903.07742306437;4810.326554282403;4837.975810120927;4946.5795407390415;5142.640015198937;5146.228065790124;382502;384093;386594;387829;388177;40324.19351612951;66926.66536667285;67234;67257.66371168113;67297.66351168213;41131.38302925458;41332.586674133476;41367.58632413697;41420.792896035324;41431.378529322086;15830.129342886252;15901.045937243802;15940.92029539845;15951.840481595267;15960.441384551485;11845.5854045108;11948.044156467462;12112.15214934946;12824.679383015313;12912.096153269182;9537.14165725088;9653.517324133765;9673.129418352382;9725.221982241404;9749.31754777173;3674.1733110050027;3699.5005674233635;3712.535933008374;3717.2937141942944;3769.453429252743;1021.867157269565;1035.1201478743008;1106.3417266726285;1172.2966220267772;1218.1594699657207;34987.82506087453;35006.12484687903;35047.824760876036;35054.64945350514;35386.64613353885;1101.6860194844592;1132.9490172942237;1134.2003887259461;1171.0865524890428;1205.37320593291;17386.65226695459;18418.35535756242;18530.25878964853;18544.907275463538;18723.625527489374;605886;607231;609200;609913;613565;64874;65333.673331633036;65339.67330163414;65481;65496.67251663711;1309.2733532889147;1363.0390574644853;1406.0860440713618;1440.2150827798876;1446.4720377062506;33587;36345.81827090848;36589.81705091564;36663.450048248764;36911.26177476489;55633.443665564446;62080.37919620746;64568.677156613914;64645.67677161772;69421.65289173521;518670;522398;522437;525063;526239;31140.68859311378;31538.842305788323;31722.841385792923;33252.50121248135;49449.25826112539;53469;53925.46074539205;54212;54218.186727199914;54595;40917.59082409138;41031.17937641171;41149.177016460104;41670.79164604157;42681.573184269;46225.537744622125;46331.30503042389;46536;46849.76575117239;46925.530744692114;44586.77706611446;45354.31968520541;45797.08405831798;46464;46596.30105548352;38145.855624331314;39623.40564891471;40023.39964900471;40990.79504602458;41373.172536548496;29899.55150672785;30198.245043874078;30363.2409189772;30647.54028689616;30795 15:33:27 INFO - PROCESS | 20392 | |2;jquery.html;390.8866428735667;435.70154444205724;437.2304743651174;442.8604989428331;447.3161033797215;17015.31938722451;19556.31552895647;21221.57556848864;21997.890010549923;22171.6674249886;12717.491300347998;16173.91913040433;19461.805381946175;19803.801961980374;20021.59956800863;5542.722863856811;5741.655500669973;5745.454181852718;5751.856203594902;5752.626079304852;5639.097744360903;5772.134179873032;6013.51891848651;6033.879322413571;6128.877422451548;5970.313413957385;6089.421504957044;6108.419700128481;6109.755609775626;6110.358412366704;6578.539502234821;6774.187097548301;6800.489963252776;6805.965970170142;6816.079829223041;5269.341332333458;5494.2857428534435;5534.778608855641;6114.419130182626;6119.571629985903;14933;15181.013234139746;15196.544103676797;21865.453363666034;24541.87729061361;2613.085420102968;2669.305980445098;2735.8084934054623;2753.4630747004344;2764.5023895698764;10725.731856703567;10863.891361086446;11172.888271117266;11182.16133789969;11331.263467874562;1928.864979451439;2014.6977953306975;2036.5519585691272;2048.979510204894;2049.415916463801;88807;89595;92890;93076.53461732648;93213;10616.94691526553;11143.721406964729;11170.497327620276;11302.773944521063;11632.05637604015;15152.31814568347;16037.117958512394;16056.357745690275;16243.350265989464;16606.916965415097;7199.460040496983;8932.732018039469;8991.505467199237;9049.81900361989;9196.12636799503;8622.223999840044;8624.985814168138;8628.396012279205;8702.651893924172;8843.60203790831;5147.742612869341;5154.14956532168;5197.610179236573;5223.596997320087;5316.149416093406;1966.2429964463784;1994.5811379610445;2056.640087984597;2068.369147410024;2140.7645159032495;919.1773362840354;949.292776881228;957.1481381570269;1019.9949000254951;1093.0708897437114;20686.17255309771;20690.068946897427;20786.58426831455;20817.06323215459;20884.686729699068;1007.2646967713611;1018.7453136715822;1029.6036026129843;1042.5204405973336;1047.6280920273346;10529.473526323653;11442.427878606037;11523;11578.884211157949;11606.477708503138;399522;400039;404107;505904;554904;60281;86894;106205;108907;109523.45238273917;1096.5394534295615;1099.1920938110482;1126.4086354663702;1126.5212284778936;1130.5873356224918;18350.357737479124;18494.167762450452;18893.24427022959;18919.43241702751;19429.93135377568;41148.1770364585;44590.55409445864;45366;45422.77288613536;46073.76963115297;60316.396836032836;60588.69705651444;60711.39288607057;61968;62061.379386207365;9277.48973806447;9344.392614480037;9437.622495100119;9552.95223523878;9641.035896410303;13214.933925330311;13828.516001940287;14003.719925601634;14152.78770818418;14413.13521188732;10579.735506612396;11514.53941842317;11577.536898523964;12033.157678962738;12157.75684486323;11776.823347649963;11935.82096268574;12154.574589889311;12201.69495762613;12800.87199128034;11425.428728563373;11557.653270401901;11653.126015549038;11723;12075.154739168174;8969.686060987835;9167;9217.58520866576;9280.303977201602;9482.38364506305;10518.684439466828;11279.774404512027;11357.772844542898;11541.249818761753;11800.114991375853 15:33:27 INFO - PROCESS | 20392 | |3;mootools.html;1374.6838227207736;1526.8320484746673;1561.6017915431564;1760.9471715848529;1870.3360307090982;8077.111517733045;9455.10176533229;9780.559874805633;9789.461579613118;9811.558479868396;9578.568964396602;9647.61409543619;9662.661806836744;9670.951645241781;9673.564689588968;2510.1967370441466;2525.3434107132184;2531.7847982921476;2536.2137737301405;2536.5941449368106;2474.1711526638596;2498.6876640419855;2507.69907611086;2526.178991827654;2530.228280374485;2442.9144979925704;2454.410941374066;2509.8870550825163;2516.207394670682;2539.987300063497;2369.5024044950496;2381.821363397752;2391.2467572714627;2424.490856920049;2426.696662917135;2376.3108698477595;2397.184957114572;2404.302752201859;2405.2183040511904;2423.9878800605884;9375.812483750355;9527.761805954906;9602.183814375716;9609.327347085708;9618.759531011781;5557.666540007613;5769.596128271022;5773.191753154561;5773.24947756789;5776.104703770922;3491.738119641037;3503.5095086687884;3521.9471707924404;3526.1360966563357;3568.107973006748;1199.8140288255333;1210.8728583498694;1224.7795396828567;1245.819356193347;1255.899528037764;13485.258310792902;13552.59342219735;13563.254021028839;13564;13577.864221357857;4728.639984168632;4814.422269327633;4839.661223714376;4889.242167464049;4972.65191436596;10542.209334299958;10543.578256869792;10546.62893823798;10549.578016879239;10553.419561924167;5550.278463799761;5550.72246387679;5556.388797232301;5563.527100196528;5565.387807341189;4537.274036154266;4641.396618439581;5032.572231360302;5100.5409513143995;5201.505856943584;4207.137536804948;4217.641500472494;4234.449521562177;4269.765162916007;4309.1381723655395;1262.299423819789;1263.3872571802851;1269.6635391621228;1299.7465494228725;1300.830891984036;860.7891066688576;954.7613096725819;969.8642190093393;991.053543865621;1009.8033829911432;6013.037913933749;6118.1128736332985;6138.109974053827;6149.2620885494025;6167.352427994996;450.85572616762323;471.40132032318763;471.7947692753663;472.1383475157851;481.7759741720117;4077.8989672788775;4154.1068670236045;4213.115245798355;4242.278812601865;4253.659707223414;11922.523099076114;12134.939325303318;12225;12237.082218833622;12278.815817762741;11370.545178192946;11788.705282367839;12166.148369614219;12201;12207.633770986708;8786.516741579275;9002.729918102468;9015.684451044182;9025.954870225607;9031.683891063782;5857.882842343044;5940.8811823764145;5986.970065149646;6055.364186760326;6187.907181392193;10691.839622405825;10874.782504350027;10957.397343146204;10968.670939871816;11348.602798901999;11383.715407114889;11419.657410277705;11506.76986460283;11513.251638643796;11546.59586914454;8479.745607631781;8685.522296273513;8802.031776504451;8813.20681138675;8820.514871681862;8947.865782013405;9164.450132992042;9221.446713197229;9245.214156796479;9250.398724082914;7945.682172713026;8125.878111828446;8172.223638754309;8231.629576668944;8318.750437486886;7743.57410342414;7872.409569282441;7954.840903181788;7980.12218655959;8133.308668763221;7018.122734658168;7051.400630946222;7051.541649792747;7057.964710176417;7076.32774886385;5284.81503147388;5296.41739408657;5347.278117454094;5351.625386222927;5460.044492213926;5319.335083114611;5366.329208848894;5549.750261238335;5582.106862901916;5583.664980101207 15:33:27 INFO - PROCESS | 20392 | |4;prototype.html;339.9490076488526;345.6923338228976;354.98474363320895;360.36575626896655;365.92315613721115;5497.642653227543;5585.52523035542;5603.915941260884;5627.859303517414;5628.902364039014;5494.241842610366;5509.972450137754;5513.531349835269;5520.972395138018;5521.1442226454965;4083.8774836754947;4364.454443194601;4408.118376324732;4409.647228221743;4421.292593185091;4035.9192816143805;4355.586219309161;4367.759773212472;4374;4379.34309853523;4329.1558146161515;4329.826806927719;4336.3712261722185;4337.1976184405985;4353.390525326457;4118.114605359862;4178.791060446965;4365.912681746363;4369.73781573105;4375.671824613167;3740.2706472237924;3776.7922764247955;3790.924181516354;3807.9809600952094;3808.9619103808886;5353.411124776271;5366.195070739382;5373.35519737634;5378.865528361783;5428.104362780136;4771.9522804772205;4918.901621967577;4943.480934501861;4969.13040217964;4974.179260422026;5755;5766.654000759926;5769.336526299488;5771.307443106854;5789.681567513785;4252.851150209728;4271.1671224111315;4273.423087883127;4280.282020916709;4282.5075116361395;5823.941760582382;5912.965231084543;5951.851203719898;6030.7889223876955;6060.848478788022;4334.674899382496;4336.07044865032;4342.609165175086;4368.4102646143;4376.3654270130655;4423.562342238785;4454.131444368317;4454.688171828006;4483.310013991579;4501.122281155143;4670.785595745063;4941;5064.797408103708;5068.949310506921;5070.2141168119;5822.272215973004;5826.533877289807;5835.503982161564;5854.824355269348;5868.853278668067;1497.423491955605;1518.400231908412;1523.8095238095239;1526.4809964612086;1527.6562773375902;937.2408349237139;972.6304004478394;977.6920270114891;983.6409710455632;996.8056229035268;5011.824586139468;5446.836594902159;5447.700376479332;5552.222688823568;5633.295838020247;5934.37689042653;5941.55438342126;5950.166976623276;5975.880482390327;5979.641221526722;5547.5007249347755;5673.8297851064535;5695.515881150149;5714.000049991235;5729.169270455761;3109.300407408315;3134.996801023696;3151.9684803152136;3153.3377990621766;3155.2269693925136;6100.206973093558;6101.786437474667;6128.754849806047;6162.753489860355;6168.722407491674;5969.761209551656;6037.305709843425;6078.696065196723;6130.908036379458;6165.10605962133;6132.2947860996555;6142.293636231801;6146.926536731634;6158.1686472326555;6167.722452489559;5700.686462244616;5957.165996760544;5985.461308482258;5996.190514280691;6001.819945401645;5890.293164820249;5892.939270931273;5917.437843404869;5921.970390148022;5939.07944268639;5868.413158684098;6129.295131059806;6136.956717357971;6145.6927153641245;6183;4249.087910440376;4316.1151963846705;4326.610605045561;4327.480702315742;4345.934810977901;5974.581779275582;5995.95070862606;5999.820005399845;6020.668863212565;6026.608270462406;5610.438956104357;5883.323417807007;5889.469947704727;5899.764009439575;5913.349531551612;5893;5896.204012458435;5906.852328691817;5907.675077870586;5910.408959104056;5811.157382179645;5851.5663662402985;5859.20900678403;5869.8239052828485;5924.703764811656;5693.3168019837885;5860.443257890493;5874.735636896265;5900.380460051632;5935.376785437467;5774.220480235114;5781;5793.913091303718;5800.230929566523;5871 15:33:27 INFO - PROCESS | 20392 | |5;yui.html;807.8868958345831;832.5379414424991;839.5340585974782;856.4604299291448;914.6099515911436;16361.345546178154;17937.461876143705;18025.819741802577;18175.636487270247;18338;14699.044562103456;14788.260586970635;14824.258787060631;14885;16217.83782162178;855.170484629908;862.8101817600118;864.2955990867455;864.6195673903494;865.4417900454204;715.1311156944312;727.5743689941364;825.8059356051323;855.6064210463195;858.3519442820661;906.0033962641108;907.2469850024497;907.5190149220923;909.2544113826632;909.5997760985179;744.4007573903006;905.0135352465811;905.2395987370608;905.5110240470138;911.1389736698823;563.5153767759723;635.0537698828758;657.9407853293179;663.8274048747361;665.6272487407067;16445.342186312653;16505.917470412693;16592.66814663712;16633.251503682364;16635.251413686412;13560.932195339059;14161.433542658282;14439.639009024753;14476;14570.562883113524;13636.113652612648;13748.862511374959;13826.792598111037;13947.930260348734;14055.929720351332;4427.424434823484;4503.347014682852;4515.14212299662;4574.1309151261485;4600.792964316581;83319.87357800195;86494.13505864923;87069.12930870737;87281;88361.55819220927;11442.084633229488;11674.124440666985;11683.824742628867;12087.637370878887;12135.939320303341;19392.612147756965;19396.2241510338;19399.709004364944;19402;19408;8307.37694672902;8342.791430214293;8357.791055223546;8674.04585495595;8703.042665306812;4913.091078150554;4998.4251811042195;5009.5741861941415;5019.899602007939;5117.974410128;3710.9072273193387;3846.442265871433;3847.4228865670375;3848.8845334640005;3855.7879316637295;627.4603840696997;631.2834932351814;637.1971316141695;639.7217210513442;651.8728847874713;651.1795138125996;711.7046425733366;733.1495465260273;744.6053591596462;762.7635433015782;8891.73324800257;9397.201237894718;9684.661036863818;9926.305158638826;10227.335223210468;654.5974225851068;746.4625469661943;748.1172216784138;750.6659536506312;775.7052320118319;4484.1255955088445;4783.354247176656;4794.089123066676;4797.232442809134;4824.8793780155775;133226;135843.32078339742;139321;140537;148231;68027.65986170038;91913.5404322974;92760;120820.39589801995;121762;56685;58555.70722146447;84069.57965210258;90502;92363.95888247255;8995.775105622412;9242.445453272825;9930.652427165014;10085.647002354883;10273.589056437957;41486.377704335064;46957;51268.230976534636;53008.46991530035;56856.43143568511;52522;53738.46261537335;60692.69653651703;71794;79351;13335.599932002055;13505.32473376347;13613.591592252249;14267.07264027835;14774.409023638935;14575.927120364755;16278.837211627731;16498.457668233783;16964.406245781338;17966.820331796516;14400.927995359956;14607.269636518344;14798.926005369904;15240.847591524387;15622.453214137451;14179.361928713439;14560.053596516193;15145.091294522364;15227.923860380628;15446.30491627857;13434.93282533581;14080.78878816798;14352.995290329576;14387.92806036005;14808.25958702082;11981.700457488283;12037.097217708531;12267.815982760087;12485.875141248835;12624.053196010153;11908.166428349932;12823.230606163661;12978.58082450145;13059.542915997894;13167.144135631153 15:33:27 INFO - PROCESS | 20392 | __end_tp_report 15:33:27 INFO - PROCESS | 20392 | __start_cc_report 15:33:27 INFO - PROCESS | 20392 | _x_x_mozilla_cycle_collect,936 15:33:27 INFO - PROCESS | 20392 | __end_cc_report 15:33:27 INFO - PROCESS | 20392 | __startTimestamp1475015607783__endTimestamp 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | ------- Summary: start ------- 15:33:27 INFO - PROCESS | 20392 | Number of tests: 6 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#0] dojo.html Cycles:165 Average:5710.35 Median:5912.85 stddev:657.04 (11.1%) stddev-sans-first:627.56 15:33:27 INFO - PROCESS | 20392 | Values: 3148.2 3181.1 3196.5 3214.0 3230.0 5698.0 5746.1 5784.8 5800.5 5817.2 5706.7 5775.8 5785.5 5792.2 5796.8 5264.6 5265.3 5289.2 5307.6 5357.0 5177.7 5359.2 5371.7 5373.8 5390.4 5143.9 5220.5 5232.5 5284.0 5293.6 5226.7 5247.4 5255.0 5363.6 5364.6 5185.8 5212.5 5282.6 5297.0 5311.3 5481.3 5526.2 5572.4 5625.3 5670.8 5995.1 6008.4 6017.5 6106.1 6110.7 6144.5 6145.8 6155.9 6155.9 6158.8 5648.0 5660.1 5692.8 5708.2 5715.6 6315.3 6346.7 6348.6 6350.2 6353.5 6091.8 6092.7 6094.6 6094.7 6099.3 5918.6 5950.5 6124.6 6135.8 6159.2 6214.5 6215.4 6215.5 6219.1 6227.1 6150.0 6171.9 6221.2 6227.8 6230.8 4610.4 4666.6 4673.9 4757.2 4784.6 4160.4 4163.2 4169.5 4205.4 4215.2 5822.7 5865.6 5866.4 5872.0 5905.6 5921.9 5984.9 6198.4 6199.8 6209.5 5807.2 5888.5 5905.5 5953.7 5992.6 5358.9 5385.5 5397.7 5403.2 5411.3 6037.2 6415.7 6451.6 6484.2 6499.4 5957.3 6083.2 6134.0 6149.4 6241.8 6309.0 6313.3 6313.6 6320.9 6389.5 5856.7 6106.8 6114.6 6128.1 6133.1 6000.5 6066.6 6073.3 6133.9 6189.7 5993.6 6003.3 6014.8 6018.6 6018.7 6006.8 6015.7 6016.5 6027.1 6040.1 5767.9 5780.6 5836.9 5852.5 5919.9 6028.2 6037.2 6041.9 6049.1 6051.3 5773.1 5902.6 5907.2 5911.3 5912.9 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#1] ext.html Cycles:180 Average:67136.86 Median:41010.99 stddev:136763.31 (333.5%) stddev-sans-first:137055.70 15:33:27 INFO - PROCESS | 20392 | Values: 590.2 622.0 630.3 649.1 650.2 37287.8 46992.3 47775.3 47835.3 51695.5 44633.3 44972.0 45198.3 45204.3 45351.3 8523.0 9399.5 9545.5 9554.7 9554.8 8474.9 11074.7 11344.5 11347.8 11668.4 11471.8 11548.7 11551.5 11556.2 11556.8 11412.5 11498.6 11510.8 11518.6 11538.8 11273.7 11322.7 11337.4 11338.3 11343.4 47286.0 47600.8 47615.8 47620.3 47663.8 4009.2 4182.5 4444.4 4562.5 4573.6 31385.0 35910.1 36384.3 36572.3 36903.1 4810.3 4838.0 4946.6 5142.6 5146.2 382502.0 384093.0 386594.0 387829.0 388177.0 40324.2 66926.7 67234.0 67257.7 67297.7 41131.4 41332.6 41367.6 41420.8 41431.4 15830.1 15901.0 15940.9 15951.8 15960.4 11845.6 11948.0 12112.2 12824.7 12912.1 9537.1 9653.5 9673.1 9725.2 9749.3 3674.2 3699.5 3712.5 3717.3 3769.5 1021.9 1035.1 1106.3 1172.3 1218.2 34987.8 35006.1 35047.8 35054.6 35386.6 1101.7 1132.9 1134.2 1171.1 1205.4 17386.7 18418.4 18530.3 18544.9 18723.6 605886.0 607231.0 609200.0 609913.0 613565.0 64874.0 65333.7 65339.7 65481.0 65496.7 1309.3 1363.0 1406.1 1440.2 1446.5 33587.0 36345.8 36589.8 36663.5 36911.3 55633.4 62080.4 64568.7 64645.7 69421.7 518670.0 522398.0 522437.0 525063.0 526239.0 31140.7 31538.8 31722.8 33252.5 49449.3 53469.0 53925.5 54212.0 54218.2 54595.0 40917.6 41031.2 41149.2 41670.8 42681.6 46225.5 46331.3 46536.0 46849.8 46925.5 44586.8 45354.3 45797.1 46464.0 46596.3 38145.9 39623.4 40023.4 40990.8 41373.2 29899.6 30198.2 30363.2 30647.5 30795.0 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#2] jquery.html Cycles:180 Average:28676.67 Median:12003.11 stddev:76027.09 (633.4%) stddev-sans-first:76210.70 15:33:27 INFO - PROCESS | 20392 | Values: 390.9 435.7 437.2 442.9 447.3 17015.3 19556.3 21221.6 21997.9 22171.7 12717.5 16173.9 19461.8 19803.8 20021.6 5542.7 5741.7 5745.5 5751.9 5752.6 5639.1 5772.1 6013.5 6033.9 6128.9 5970.3 6089.4 6108.4 6109.8 6110.4 6578.5 6774.2 6800.5 6806.0 6816.1 5269.3 5494.3 5534.8 6114.4 6119.6 14933.0 15181.0 15196.5 21865.5 24541.9 2613.1 2669.3 2735.8 2753.5 2764.5 10725.7 10863.9 11172.9 11182.2 11331.3 1928.9 2014.7 2036.6 2049.0 2049.4 88807.0 89595.0 92890.0 93076.5 93213.0 10616.9 11143.7 11170.5 11302.8 11632.1 15152.3 16037.1 16056.4 16243.4 16606.9 7199.5 8932.7 8991.5 9049.8 9196.1 8622.2 8625.0 8628.4 8702.7 8843.6 5147.7 5154.1 5197.6 5223.6 5316.1 1966.2 1994.6 2056.6 2068.4 2140.8 919.2 949.3 957.1 1020.0 1093.1 20686.2 20690.1 20786.6 20817.1 20884.7 1007.3 1018.7 1029.6 1042.5 1047.6 10529.5 11442.4 11523.0 11578.9 11606.5 399522.0 400039.0 404107.0 505904.0 554904.0 60281.0 86894.0 106205.0 108907.0 109523.5 1096.5 1099.2 1126.4 1126.5 1130.6 18350.4 18494.2 18893.2 18919.4 19429.9 41148.2 44590.6 45366.0 45422.8 46073.8 60316.4 60588.7 60711.4 61968.0 62061.4 9277.5 9344.4 9437.6 9553.0 9641.0 13214.9 13828.5 14003.7 14152.8 14413.1 10579.7 11514.5 11577.5 12033.2 12157.8 11776.8 11935.8 12154.6 12201.7 12800.9 11425.4 11557.7 11653.1 11723.0 12075.2 8969.7 9167.0 9217.6 9280.3 9482.4 10518.7 11279.8 11357.8 11541.2 11800.1 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#3] mootools.html Cycles:180 Average:6195.97 Median:471.97 stddev:3649.93 (773.3%) stddev-sans-first:3642.19 15:33:27 INFO - PROCESS | 20392 | Values: 1374.7 1526.8 1561.6 1760.9 1870.3 8077.1 9455.1 9780.6 9789.5 9811.6 9578.6 9647.6 9662.7 9671.0 9673.6 2510.2 2525.3 2531.8 2536.2 2536.6 2474.2 2498.7 2507.7 2526.2 2530.2 2442.9 2454.4 2509.9 2516.2 2540.0 2369.5 2381.8 2391.2 2424.5 2426.7 2376.3 2397.2 2404.3 2405.2 2424.0 9375.8 9527.8 9602.2 9609.3 9618.8 5557.7 5769.6 5773.2 5773.2 5776.1 3491.7 3503.5 3521.9 3526.1 3568.1 1199.8 1210.9 1224.8 1245.8 1255.9 13485.3 13552.6 13563.3 13564.0 13577.9 4728.6 4814.4 4839.7 4889.2 4972.7 10542.2 10543.6 10546.6 10549.6 10553.4 5550.3 5550.7 5556.4 5563.5 5565.4 4537.3 4641.4 5032.6 5100.5 5201.5 4207.1 4217.6 4234.4 4269.8 4309.1 1262.3 1263.4 1269.7 1299.7 1300.8 860.8 954.8 969.9 991.1 1009.8 6013.0 6118.1 6138.1 6149.3 6167.4 450.9 471.4 471.8 472.1 481.8 4077.9 4154.1 4213.1 4242.3 4253.7 11922.5 12134.9 12225.0 12237.1 12278.8 11370.5 11788.7 12166.1 12201.0 12207.6 8786.5 9002.7 9015.7 9026.0 9031.7 5857.9 5940.9 5987.0 6055.4 6187.9 10691.8 10874.8 10957.4 10968.7 11348.6 11383.7 11419.7 11506.8 11513.3 11546.6 8479.7 8685.5 8802.0 8813.2 8820.5 8947.9 9164.5 9221.4 9245.2 9250.4 7945.7 8125.9 8172.2 8231.6 8318.8 7743.6 7872.4 7954.8 7980.1 8133.3 7018.1 7051.4 7051.5 7058.0 7076.3 5284.8 5296.4 5347.3 5351.6 5460.0 5319.3 5366.3 5549.8 5582.1 5583.7 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#4] prototype.html Cycles:180 Average:4915.62 Median:5631.10 stddev:1439.66 (25.6%) stddev-sans-first:1402.14 15:33:27 INFO - PROCESS | 20392 | Values: 339.9 345.7 355.0 360.4 365.9 5497.6 5585.5 5603.9 5627.9 5628.9 5494.2 5510.0 5513.5 5521.0 5521.1 4083.9 4364.5 4408.1 4409.6 4421.3 4035.9 4355.6 4367.8 4374.0 4379.3 4329.2 4329.8 4336.4 4337.2 4353.4 4118.1 4178.8 4365.9 4369.7 4375.7 3740.3 3776.8 3790.9 3808.0 3809.0 5353.4 5366.2 5373.4 5378.9 5428.1 4772.0 4918.9 4943.5 4969.1 4974.2 5755.0 5766.7 5769.3 5771.3 5789.7 4252.9 4271.2 4273.4 4280.3 4282.5 5823.9 5913.0 5951.9 6030.8 6060.8 4334.7 4336.1 4342.6 4368.4 4376.4 4423.6 4454.1 4454.7 4483.3 4501.1 4670.8 4941.0 5064.8 5068.9 5070.2 5822.3 5826.5 5835.5 5854.8 5868.9 1497.4 1518.4 1523.8 1526.5 1527.7 937.2 972.6 977.7 983.6 996.8 5011.8 5446.8 5447.7 5552.2 5633.3 5934.4 5941.6 5950.2 5975.9 5979.6 5547.5 5673.8 5695.5 5714.0 5729.2 3109.3 3135.0 3152.0 3153.3 3155.2 6100.2 6101.8 6128.8 6162.8 6168.7 5969.8 6037.3 6078.7 6130.9 6165.1 6132.3 6142.3 6146.9 6158.2 6167.7 5700.7 5957.2 5985.5 5996.2 6001.8 5890.3 5892.9 5917.4 5922.0 5939.1 5868.4 6129.3 6137.0 6145.7 6183.0 4249.1 4316.1 4326.6 4327.5 4345.9 5974.6 5996.0 5999.8 6020.7 6026.6 5610.4 5883.3 5889.5 5899.8 5913.3 5893.0 5896.2 5906.9 5907.7 5910.4 5811.2 5851.6 5859.2 5869.8 5924.7 5693.3 5860.4 5874.7 5900.4 5935.4 5774.2 5781.0 5793.9 5800.2 5871.0 15:33:27 INFO - PROCESS | 20392 | 15:33:27 INFO - PROCESS | 20392 | [#5] yui.html Cycles:180 Average:21557.56 Median:4587.46 stddev:32022.13 (698.0%) stddev-sans-first:32074.06 15:33:27 INFO - PROCESS | 20392 | Values: 807.9 832.5 839.5 856.5 914.6 16361.3 17937.5 18025.8 18175.6 18338.0 14699.0 14788.3 14824.3 14885.0 16217.8 855.2 862.8 864.3 864.6 865.4 715.1 727.6 825.8 855.6 858.4 906.0 907.2 907.5 909.3 909.6 744.4 905.0 905.2 905.5 911.1 563.5 635.1 657.9 663.8 665.6 16445.3 16505.9 16592.7 16633.3 16635.3 13560.9 14161.4 14439.6 14476.0 14570.6 13636.1 13748.9 13826.8 13947.9 14055.9 4427.4 4503.3 4515.1 4574.1 4600.8 83319.9 86494.1 87069.1 87281.0 88361.6 11442.1 11674.1 11683.8 12087.6 12135.9 19392.6 19396.2 19399.7 19402.0 19408.0 8307.4 8342.8 8357.8 8674.0 8703.0 4913.1 4998.4 5009.6 5019.9 5118.0 3710.9 3846.4 3847.4 3848.9 3855.8 627.5 631.3 637.2 639.7 651.9 651.2 711.7 733.1 744.6 762.8 8891.7 9397.2 9684.7 9926.3 10227.3 654.6 746.5 748.1 750.7 775.7 4484.1 4783.4 4794.1 4797.2 4824.9 133226.0 135843.3 139321.0 140537.0 148231.0 68027.7 91913.5 92760.0 120820.4 121762.0 56685.0 58555.7 84069.6 90502.0 92364.0 8995.8 9242.4 9930.7 10085.6 10273.6 41486.4 46957.0 51268.2 53008.5 56856.4 52522.0 53738.5 60692.7 71794.0 79351.0 13335.6 13505.3 13613.6 14267.1 14774.4 14575.9 16278.8 16498.5 16964.4 17966.8 14400.9 14607.3 14798.9 15240.8 15622.5 14179.4 14560.1 15145.1 15227.9 15446.3 13434.9 14080.8 14353.0 14387.9 14808.3 11981.7 12037.1 12267.8 12485.9 12624.1 11908.2 12823.2 12978.6 13059.5 13167.1 15:33:27 INFO - PROCESS | 20392 | -------- Summary: end -------- 15:33:27 INFO - PROCESS | 20392 | 15:33:28 INFO - TEST-INFO | 20392: exit 0 15:33:28 INFO - TEST-OK | dromaeo_css | took 1114444ms 15:33:28 INFO - TEST-START | kraken 15:33:28 INFO - operating with platform_type : linux_ 15:33:28 INFO - Initialising browser for kraken test... 15:33:28 INFO - TEST-INFO | started process 20711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgUOmm7/profile http://localhost:45043/getInfo.html) 15:33:32 INFO - PROCESS | 20711 | __metrics Screen width/height:1600/1200 15:33:32 INFO - PROCESS | 20711 | colorDepth:24 15:33:32 INFO - PROCESS | 20711 | Browser inner width/height: 1024/697 15:33:32 INFO - PROCESS | 20711 | __metrics 15:33:33 INFO - PROCESS | 20711 | 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" 15:33:33 INFO - PROCESS | 20711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:34 INFO - PROCESS | 20711 | console.error: PushService: 15:33:34 INFO - PROCESS | 20711 | stateChangeProcessEnqueue: Error transitioning state 15:33:34 INFO - PROCESS | 20711 | UnknownError 15:33:34 INFO - TEST-INFO | 20711: exit 0 15:33:34 INFO - Browser initialized. 15:33:34 INFO - Running cycle 1/1 for kraken test... 15:33:34 INFO - TEST-INFO | started process 20804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgUOmm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:46 INFO - PROCESS | 20804 | RSS: Main: 144498688 15:33:46 INFO - PROCESS | 20804 | 15:33:49 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45043/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:49 INFO - PROCESS | 20804 | RSS: Main: 185487360 15:33:49 INFO - PROCESS | 20804 | 15:33:52 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45043/tests/kraken/driver.html?testName=audio-dft) 15:33:53 INFO - PROCESS | 20804 | RSS: Main: 175071232 15:33:53 INFO - PROCESS | 20804 | 15:33:55 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45043/tests/kraken/driver.html?testName=audio-fft) 15:33:56 INFO - PROCESS | 20804 | RSS: Main: 265797632 15:33:56 INFO - PROCESS | 20804 | 15:33:58 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45043/tests/kraken/driver.html?testName=audio-oscillator) 15:33:59 INFO - PROCESS | 20804 | RSS: Main: 172961792 15:33:59 INFO - PROCESS | 20804 | 15:34:01 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:01 INFO - PROCESS | 20804 | RSS: Main: 173670400 15:34:01 INFO - PROCESS | 20804 | 15:34:04 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45043/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:05 INFO - PROCESS | 20804 | RSS: Main: 210153472 15:34:05 INFO - PROCESS | 20804 | 15:34:08 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45043/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:09 INFO - PROCESS | 20804 | RSS: Main: 209637376 15:34:09 INFO - PROCESS | 20804 | 15:34:12 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45043/tests/kraken/driver.html?testName=json-parse-financial) 15:34:12 INFO - PROCESS | 20804 | RSS: Main: 209530880 15:34:12 INFO - PROCESS | 20804 | 15:34:14 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:14 INFO - PROCESS | 20804 | RSS: Main: 171020288 15:34:14 INFO - PROCESS | 20804 | 15:34:16 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:17 INFO - PROCESS | 20804 | RSS: Main: 178253824 15:34:17 INFO - PROCESS | 20804 | 15:34:18 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:19 INFO - PROCESS | 20804 | RSS: Main: 183820288 15:34:19 INFO - PROCESS | 20804 | 15:34:22 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:22 INFO - PROCESS | 20804 | RSS: Main: 185401344 15:34:22 INFO - PROCESS | 20804 | 15:34:25 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:25 INFO - PROCESS | 20804 | RSS: Main: 182034432 15:34:25 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | Cycle 1(1): loaded http://localhost:45043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45043/tests/kraken/driver.html?testName=ai-astar) 15:34:27 INFO - PROCESS | 20804 | RSS: Main: 234209280 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | __start_tp_report 15:34:27 INFO - PROCESS | 20804 | _x_x_mozilla_page_load 15:34:27 INFO - PROCESS | 20804 | _x_x_mozilla_page_load_details 15:34:27 INFO - PROCESS | 20804 | |i|pagename|runs| 15:34:27 INFO - PROCESS | 20804 | |0;ai-astar;109;113;111;112;111;111;111;111;113;111 15:34:27 INFO - PROCESS | 20804 | |1;audio-beat-detection;145;120;120;150;118;118;117;117;155;122 15:34:27 INFO - PROCESS | 20804 | |2;audio-dft;162;162;160;162;161;162;161;162;161;162 15:34:27 INFO - PROCESS | 20804 | |3;audio-fft;76;76;74;108;76;75;75;76;99;74 15:34:27 INFO - PROCESS | 20804 | |4;audio-oscillator;82;83;126;82;82;82;98;81;82;115 15:34:27 INFO - PROCESS | 20804 | |5;imaging-gaussian-blur;117;117;117;118;118;116;117;116;117;118 15:34:27 INFO - PROCESS | 20804 | |6;imaging-darkroom;145;145;145;147;146;146;146;147;145;146 15:34:27 INFO - PROCESS | 20804 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;96;95 15:34:27 INFO - PROCESS | 20804 | |8;json-parse-financial;52;49;50;50;50;52;51;51;50;50 15:34:27 INFO - PROCESS | 20804 | |9;json-stringify-tinderbox;58;59;61;58;59;59;59;59;59;60 15:34:27 INFO - PROCESS | 20804 | |10;stanford-crypto-aes;74;81;75;73;73;74;73;73;77;73 15:34:27 INFO - PROCESS | 20804 | |11;stanford-crypto-ccm;127;121;136;119;119;118;125;119;164;122 15:34:27 INFO - PROCESS | 20804 | |12;stanford-crypto-pbkdf2;147;149;149;150;151;151;148;152;155;150 15:34:27 INFO - PROCESS | 20804 | |13;stanford-crypto-sha256-iterative;62;63;63;62;62;61;62;61;60;61 15:34:27 INFO - PROCESS | 20804 | __end_tp_report 15:34:27 INFO - PROCESS | 20804 | __start_cc_report 15:34:27 INFO - PROCESS | 20804 | _x_x_mozilla_cycle_collect,1589 15:34:27 INFO - PROCESS | 20804 | __end_cc_report 15:34:27 INFO - PROCESS | 20804 | __startTimestamp1475015667841__endTimestamp 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | ------- Summary: start ------- 15:34:27 INFO - PROCESS | 20804 | Number of tests: 14 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.16 (1.0%) stddev-sans-first:0.88 15:34:27 INFO - PROCESS | 20804 | Values: 109.0 113.0 111.0 112.0 111.0 111.0 111.0 111.0 113.0 111.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:121.00 stddev:15.30 (12.6%) stddev-sans-first:14.97 15:34:27 INFO - PROCESS | 20804 | Values: 145.0 120.0 120.0 150.0 118.0 118.0 117.0 117.0 155.0 122.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 15:34:27 INFO - PROCESS | 20804 | Values: 162.0 162.0 160.0 162.0 161.0 162.0 161.0 162.0 161.0 162.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.12 (16.0%) stddev-sans-first:12.73 15:34:27 INFO - PROCESS | 20804 | Values: 76.0 76.0 74.0 108.0 76.0 75.0 75.0 76.0 99.0 74.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:16.39 (20.0%) stddev-sans-first:17.04 15:34:27 INFO - PROCESS | 20804 | Values: 82.0 83.0 126.0 82.0 82.0 82.0 98.0 81.0 82.0 115.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 15:34:27 INFO - PROCESS | 20804 | Values: 117.0 117.0 117.0 118.0 118.0 116.0 117.0 116.0 117.0 118.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 15:34:27 INFO - PROCESS | 20804 | Values: 145.0 145.0 145.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 15:34:27 INFO - PROCESS | 20804 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:0.97 (1.9%) stddev-sans-first:0.87 15:34:27 INFO - PROCESS | 20804 | Values: 52.0 49.0 50.0 50.0 50.0 52.0 51.0 51.0 50.0 50.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.83 15:34:27 INFO - PROCESS | 20804 | Values: 58.0 59.0 61.0 58.0 59.0 59.0 59.0 59.0 59.0 60.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.59 (3.5%) stddev-sans-first:2.74 15:34:27 INFO - PROCESS | 20804 | Values: 74.0 81.0 75.0 73.0 73.0 74.0 73.0 73.0 77.0 73.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.50 stddev:14.09 (11.4%) stddev-sans-first:14.95 15:34:27 INFO - PROCESS | 20804 | Values: 127.0 121.0 136.0 119.0 119.0 118.0 125.0 119.0 164.0 122.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:150.50 stddev:2.25 (1.5%) stddev-sans-first:2.07 15:34:27 INFO - PROCESS | 20804 | Values: 147.0 149.0 149.0 150.0 151.0 151.0 148.0 152.0 155.0 150.0 15:34:27 INFO - PROCESS | 20804 | 15:34:27 INFO - PROCESS | 20804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 15:34:27 INFO - PROCESS | 20804 | Values: 62.0 63.0 63.0 62.0 62.0 61.0 62.0 61.0 60.0 61.0 15:34:27 INFO - PROCESS | 20804 | -------- Summary: end -------- 15:34:27 INFO - PROCESS | 20804 | 15:34:28 INFO - TEST-INFO | 20804: exit 0 15:34:28 INFO - TEST-OK | kraken | took 60272ms 15:34:28 INFO - SUITE-END | took 1174s 15:34:29 INFO - Completed test suite (00:19:34) 15:34:29 INFO - javascript benchmark 15:34:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.2444213388785, 3181.0774875286174, 3196.504541796021, 3214.0, 3229.9677003229963, 5697.971510142449, 5746.0806270996645, 5784.797532086378, 5800.53595712343, 5817.243758311419, 5706.686132262724, 5775.768969241225, 5785.5082318002915, 5792.218050563172, 5796.768129274835, 5264.578833693296, 5265.289185959894, 5289.18017707256, 5307.628466007381, 5357.035733567956, 5177.663451875635, 5359.222912677659, 5371.677699338053, 5373.838784836442, 5390.353157621072, 5143.871403214912, 5220.504052115043, 5232.45059268777, 5284.0, 5293.550048245904, 5226.660267082647, 5247.370315562119, 5255.0, 5363.597730170214, 5364.597655175839, 5185.766640501187, 5212.50481204285, 5282.550983166436, 5297.0, 5311.336082989626, 5481.314835645544, 5526.226328314039, 5572.3870374258795, 5625.268715067056, 5670.773169073233, 5995.130706047598, 6008.36912124225, 6017.548683848729, 6106.084087386927, 6110.725017374184, 6144.539159563051, 6145.784897528565, 6155.907661385083, 6155.907661385083, 6158.784442544489, 5647.971760141214, 5660.094384898479, 5692.829215123553, 5708.172315014342, 5715.599908006483, 6315.305316415191, 6346.746130154742, 6348.555601107878, 6350.237971443364, 6353.4599559038, 6091.786787462417, 6092.695365231721, 6094.603850749687, 6094.695265236721, 6099.268087829489, 5918.556108291896, 5950.5239580834295, 6124.6325220486915, 6135.845176233341, 6159.23009623797, 6214.471769899519, 6215.440610345, 6215.533834962396, 6219.067139929047, 6227.06594010893, 6150.0, 6171.858206231862, 6221.160143380676, 6227.816714824169, 6230.7507699691505, 4610.4467463903875, 4666.556677115668, 4673.929891051569, 4757.215059515211, 4784.617230621542, 4160.417541544186, 4163.167366526707, 4169.45797046382, 4205.411242426063, 4215.178040282177, 5822.650640961556, 5865.589766798731, 5866.442687944724, 5871.9706401468575, 5905.616134951214, 5921.911171332434, 5984.850378740566, 6198.380161983856, 6199.845003874939, 6209.5032397408095, 5807.157962095473, 5888.499477544457, 5905.498032667186, 5953.672548009815, 5992.550558708027, 5358.946410535923, 5385.515303622693, 5397.676139431646, 5403.162509810985, 5411.2965314508865, 6037.18498002764, 6415.711292991827, 6451.580647257913, 6484.189476315555, 6499.382558657015, 5957.3446920837805, 6083.239595050619, 6133.969330153321, 6149.385061493994, 6241.812745617639, 6308.990561510136, 6313.305536390902, 6313.558050936574, 6320.905186422299, 6389.520785941166, 5856.736446859987, 6106.755729770759, 6114.602550834182, 6128.050152226412, 6133.080037994337, 6000.489958353414, 6066.636001839727, 6073.271207455134, 6133.877322453615, 6189.721462534107, 5993.61041532299, 6003.279606447254, 6014.789482368096, 6018.578699491169, 6018.699065046642, 6006.819795406145, 6015.6691381974415, 6016.5487588431915, 6027.126066720389, 6040.0939859019745, 5767.8558036049435, 5780.5953583248765, 5836.941630583639, 5852.473277405054, 5919.85200369977, 6028.216331876828, 6037.245344331958, 6041.909371359521, 6049.092636104443, 6051.273847138372, 5773.134029895549, 5902.61632993854, 5907.202527658883, 5911.3201981772645, 5912.852178695567], "value": 5664.387391930571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2356448399322, 621.9720112594932, 630.3412933484508, 649.1463725201357, 650.1775254303305, 37287.81356093219, 46992.295115573295, 47775.28337074942, 47835.28247076288, 51695.48304516963, 44633.330500042444, 44972.0, 45198.32202516957, 45204.321935171, 45351.31973020407, 8523.0, 9399.483028433433, 9545.52272386378, 9554.665586704466, 9554.761130971747, 8474.872876906851, 11074.723131921686, 11344.546218151265, 11347.829782553268, 11668.41657917105, 11471.827922581168, 11548.71128221797, 11551.53793848245, 11556.191066625339, 11556.82664760025, 11412.54349826006, 11498.597549085825, 11510.827337589943, 11518.596849110241, 11538.76922461546, 11273.718157046058, 11322.716932076682, 11337.433128343633, 11338.263012904135, 11343.43282835855, 47286.0, 47600.761996190144, 47615.76192119052, 47620.28569571424, 47663.76168119172, 4009.1781184857327, 4182.498100227962, 4444.355568442557, 4562.498125206224, 4573.565511276423, 31385.0, 35910.102247444025, 36384.272314553564, 36572.26855462902, 36903.07742306437, 4810.326554282403, 4837.975810120927, 4946.5795407390415, 5142.640015198937, 5146.228065790124, 382502.0, 384093.0, 386594.0, 387829.0, 388177.0, 40324.19351612951, 66926.66536667285, 67234.0, 67257.66371168113, 67297.66351168213, 41131.38302925458, 41332.586674133476, 41367.58632413697, 41420.792896035324, 41431.378529322086, 15830.129342886252, 15901.045937243802, 15940.92029539845, 15951.840481595267, 15960.441384551485, 11845.5854045108, 11948.044156467462, 12112.15214934946, 12824.679383015313, 12912.096153269182, 9537.14165725088, 9653.517324133765, 9673.129418352382, 9725.221982241404, 9749.31754777173, 3674.1733110050027, 3699.5005674233635, 3712.535933008374, 3717.2937141942944, 3769.453429252743, 1021.867157269565, 1035.1201478743008, 1106.3417266726285, 1172.2966220267772, 1218.1594699657207, 34987.82506087453, 35006.12484687903, 35047.824760876036, 35054.64945350514, 35386.64613353885, 1101.6860194844592, 1132.9490172942237, 1134.2003887259461, 1171.0865524890428, 1205.37320593291, 17386.65226695459, 18418.35535756242, 18530.25878964853, 18544.907275463538, 18723.625527489374, 605886.0, 607231.0, 609200.0, 609913.0, 613565.0, 64874.0, 65333.673331633036, 65339.67330163414, 65481.0, 65496.67251663711, 1309.2733532889147, 1363.0390574644853, 1406.0860440713618, 1440.2150827798876, 1446.4720377062506, 33587.0, 36345.81827090848, 36589.81705091564, 36663.450048248764, 36911.26177476489, 55633.443665564446, 62080.37919620746, 64568.677156613914, 64645.67677161772, 69421.65289173521, 518670.0, 522398.0, 522437.0, 525063.0, 526239.0, 31140.68859311378, 31538.842305788323, 31722.841385792923, 33252.50121248135, 49449.25826112539, 53469.0, 53925.46074539205, 54212.0, 54218.186727199914, 54595.0, 40917.59082409138, 41031.17937641171, 41149.177016460104, 41670.79164604157, 42681.573184269, 46225.537744622125, 46331.30503042389, 46536.0, 46849.76575117239, 46925.530744692114, 44586.77706611446, 45354.31968520541, 45797.08405831798, 46464.0, 46596.30105548352, 38145.855624331314, 39623.40564891471, 40023.39964900471, 40990.79504602458, 41373.172536548496, 29899.55150672785, 30198.245043874078, 30363.2409189772, 30647.54028689616, 30795.0], "value": 21203.10848670941, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.8866428735667, 435.70154444205724, 437.2304743651174, 442.8604989428331, 447.3161033797215, 17015.31938722451, 19556.31552895647, 21221.57556848864, 21997.890010549923, 22171.6674249886, 12717.491300347998, 16173.91913040433, 19461.805381946175, 19803.801961980374, 20021.59956800863, 5542.722863856811, 5741.655500669973, 5745.454181852718, 5751.856203594902, 5752.626079304852, 5639.097744360903, 5772.134179873032, 6013.51891848651, 6033.879322413571, 6128.877422451548, 5970.313413957385, 6089.421504957044, 6108.419700128481, 6109.755609775626, 6110.358412366704, 6578.539502234821, 6774.187097548301, 6800.489963252776, 6805.965970170142, 6816.079829223041, 5269.341332333458, 5494.2857428534435, 5534.778608855641, 6114.419130182626, 6119.571629985903, 14933.0, 15181.013234139746, 15196.544103676797, 21865.453363666034, 24541.87729061361, 2613.085420102968, 2669.305980445098, 2735.8084934054623, 2753.4630747004344, 2764.5023895698764, 10725.731856703567, 10863.891361086446, 11172.888271117266, 11182.16133789969, 11331.263467874562, 1928.864979451439, 2014.6977953306975, 2036.5519585691272, 2048.979510204894, 2049.415916463801, 88807.0, 89595.0, 92890.0, 93076.53461732648, 93213.0, 10616.94691526553, 11143.721406964729, 11170.497327620276, 11302.773944521063, 11632.05637604015, 15152.31814568347, 16037.117958512394, 16056.357745690275, 16243.350265989464, 16606.916965415097, 7199.460040496983, 8932.732018039469, 8991.505467199237, 9049.81900361989, 9196.12636799503, 8622.223999840044, 8624.985814168138, 8628.396012279205, 8702.651893924172, 8843.60203790831, 5147.742612869341, 5154.14956532168, 5197.610179236573, 5223.596997320087, 5316.149416093406, 1966.2429964463784, 1994.5811379610445, 2056.640087984597, 2068.369147410024, 2140.7645159032495, 919.1773362840354, 949.292776881228, 957.1481381570269, 1019.9949000254951, 1093.0708897437114, 20686.17255309771, 20690.068946897427, 20786.58426831455, 20817.06323215459, 20884.686729699068, 1007.2646967713611, 1018.7453136715822, 1029.6036026129843, 1042.5204405973336, 1047.6280920273346, 10529.473526323653, 11442.427878606037, 11523.0, 11578.884211157949, 11606.477708503138, 399522.0, 400039.0, 404107.0, 505904.0, 554904.0, 60281.0, 86894.0, 106205.0, 108907.0, 109523.45238273917, 1096.5394534295615, 1099.1920938110482, 1126.4086354663702, 1126.5212284778936, 1130.5873356224918, 18350.357737479124, 18494.167762450452, 18893.24427022959, 18919.43241702751, 19429.93135377568, 41148.1770364585, 44590.55409445864, 45366.0, 45422.77288613536, 46073.76963115297, 60316.396836032836, 60588.69705651444, 60711.39288607057, 61968.0, 62061.379386207365, 9277.48973806447, 9344.392614480037, 9437.622495100119, 9552.95223523878, 9641.035896410303, 13214.933925330311, 13828.516001940287, 14003.719925601634, 14152.78770818418, 14413.13521188732, 10579.735506612396, 11514.53941842317, 11577.536898523964, 12033.157678962738, 12157.75684486323, 11776.823347649963, 11935.82096268574, 12154.574589889311, 12201.69495762613, 12800.87199128034, 11425.428728563373, 11557.653270401901, 11653.126015549038, 11723.0, 12075.154739168174, 8969.686060987835, 9167.0, 9217.58520866576, 9280.303977201602, 9482.38364506305, 10518.684439466828, 11279.774404512027, 11357.772844542898, 11541.249818761753, 11800.114991375853], "value": 9607.493631080406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.6838227207736, 1526.8320484746673, 1561.6017915431564, 1760.9471715848529, 1870.3360307090982, 8077.111517733045, 9455.10176533229, 9780.559874805633, 9789.461579613118, 9811.558479868396, 9578.568964396602, 9647.61409543619, 9662.661806836744, 9670.951645241781, 9673.564689588968, 2510.1967370441466, 2525.3434107132184, 2531.7847982921476, 2536.2137737301405, 2536.5941449368106, 2474.1711526638596, 2498.6876640419855, 2507.69907611086, 2526.178991827654, 2530.228280374485, 2442.9144979925704, 2454.410941374066, 2509.8870550825163, 2516.207394670682, 2539.987300063497, 2369.5024044950496, 2381.821363397752, 2391.2467572714627, 2424.490856920049, 2426.696662917135, 2376.3108698477595, 2397.184957114572, 2404.302752201859, 2405.2183040511904, 2423.9878800605884, 9375.812483750355, 9527.761805954906, 9602.183814375716, 9609.327347085708, 9618.759531011781, 5557.666540007613, 5769.596128271022, 5773.191753154561, 5773.24947756789, 5776.104703770922, 3491.738119641037, 3503.5095086687884, 3521.9471707924404, 3526.1360966563357, 3568.107973006748, 1199.8140288255333, 1210.8728583498694, 1224.7795396828567, 1245.819356193347, 1255.899528037764, 13485.258310792902, 13552.59342219735, 13563.254021028839, 13564.0, 13577.864221357857, 4728.639984168632, 4814.422269327633, 4839.661223714376, 4889.242167464049, 4972.65191436596, 10542.209334299958, 10543.578256869792, 10546.62893823798, 10549.578016879239, 10553.419561924167, 5550.278463799761, 5550.72246387679, 5556.388797232301, 5563.527100196528, 5565.387807341189, 4537.274036154266, 4641.396618439581, 5032.572231360302, 5100.5409513143995, 5201.505856943584, 4207.137536804948, 4217.641500472494, 4234.449521562177, 4269.765162916007, 4309.1381723655395, 1262.299423819789, 1263.3872571802851, 1269.6635391621228, 1299.7465494228725, 1300.830891984036, 860.7891066688576, 954.7613096725819, 969.8642190093393, 991.053543865621, 1009.8033829911432, 6013.037913933749, 6118.1128736332985, 6138.109974053827, 6149.2620885494025, 6167.352427994996, 450.85572616762323, 471.40132032318763, 471.7947692753663, 472.1383475157851, 481.7759741720117, 4077.8989672788775, 4154.1068670236045, 4213.115245798355, 4242.278812601865, 4253.659707223414, 11922.523099076114, 12134.939325303318, 12225.0, 12237.082218833622, 12278.815817762741, 11370.545178192946, 11788.705282367839, 12166.148369614219, 12201.0, 12207.633770986708, 8786.516741579275, 9002.729918102468, 9015.684451044182, 9025.954870225607, 9031.683891063782, 5857.882842343044, 5940.8811823764145, 5986.970065149646, 6055.364186760326, 6187.907181392193, 10691.839622405825, 10874.782504350027, 10957.397343146204, 10968.670939871816, 11348.602798901999, 11383.715407114889, 11419.657410277705, 11506.76986460283, 11513.251638643796, 11546.59586914454, 8479.745607631781, 8685.522296273513, 8802.031776504451, 8813.20681138675, 8820.514871681862, 8947.865782013405, 9164.450132992042, 9221.446713197229, 9245.214156796479, 9250.398724082914, 7945.682172713026, 8125.878111828446, 8172.223638754309, 8231.629576668944, 8318.750437486886, 7743.57410342414, 7872.409569282441, 7954.840903181788, 7980.12218655959, 8133.308668763221, 7018.122734658168, 7051.400630946222, 7051.541649792747, 7057.964710176417, 7076.32774886385, 5284.81503147388, 5296.41739408657, 5347.278117454094, 5351.625386222927, 5460.044492213926, 5319.335083114611, 5366.329208848894, 5549.750261238335, 5582.106862901916, 5583.664980101207], "value": 4821.822073945418, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9490076488526, 345.6923338228976, 354.98474363320895, 360.36575626896655, 365.92315613721115, 5497.642653227543, 5585.52523035542, 5603.915941260884, 5627.859303517414, 5628.902364039014, 5494.241842610366, 5509.972450137754, 5513.531349835269, 5520.972395138018, 5521.1442226454965, 4083.8774836754947, 4364.454443194601, 4408.118376324732, 4409.647228221743, 4421.292593185091, 4035.9192816143805, 4355.586219309161, 4367.759773212472, 4374.0, 4379.34309853523, 4329.1558146161515, 4329.826806927719, 4336.3712261722185, 4337.1976184405985, 4353.390525326457, 4118.114605359862, 4178.791060446965, 4365.912681746363, 4369.73781573105, 4375.671824613167, 3740.2706472237924, 3776.7922764247955, 3790.924181516354, 3807.9809600952094, 3808.9619103808886, 5353.411124776271, 5366.195070739382, 5373.35519737634, 5378.865528361783, 5428.104362780136, 4771.9522804772205, 4918.901621967577, 4943.480934501861, 4969.13040217964, 4974.179260422026, 5755.0, 5766.654000759926, 5769.336526299488, 5771.307443106854, 5789.681567513785, 4252.851150209728, 4271.1671224111315, 4273.423087883127, 4280.282020916709, 4282.5075116361395, 5823.941760582382, 5912.965231084543, 5951.851203719898, 6030.7889223876955, 6060.848478788022, 4334.674899382496, 4336.07044865032, 4342.609165175086, 4368.4102646143, 4376.3654270130655, 4423.562342238785, 4454.131444368317, 4454.688171828006, 4483.310013991579, 4501.122281155143, 4670.785595745063, 4941.0, 5064.797408103708, 5068.949310506921, 5070.2141168119, 5822.272215973004, 5826.533877289807, 5835.503982161564, 5854.824355269348, 5868.853278668067, 1497.423491955605, 1518.400231908412, 1523.8095238095239, 1526.4809964612086, 1527.6562773375902, 937.2408349237139, 972.6304004478394, 977.6920270114891, 983.6409710455632, 996.8056229035268, 5011.824586139468, 5446.836594902159, 5447.700376479332, 5552.222688823568, 5633.295838020247, 5934.37689042653, 5941.55438342126, 5950.166976623276, 5975.880482390327, 5979.641221526722, 5547.5007249347755, 5673.8297851064535, 5695.515881150149, 5714.000049991235, 5729.169270455761, 3109.300407408315, 3134.996801023696, 3151.9684803152136, 3153.3377990621766, 3155.2269693925136, 6100.206973093558, 6101.786437474667, 6128.754849806047, 6162.753489860355, 6168.722407491674, 5969.761209551656, 6037.305709843425, 6078.696065196723, 6130.908036379458, 6165.10605962133, 6132.2947860996555, 6142.293636231801, 6146.926536731634, 6158.1686472326555, 6167.722452489559, 5700.686462244616, 5957.165996760544, 5985.461308482258, 5996.190514280691, 6001.819945401645, 5890.293164820249, 5892.939270931273, 5917.437843404869, 5921.970390148022, 5939.07944268639, 5868.413158684098, 6129.295131059806, 6136.956717357971, 6145.6927153641245, 6183.0, 4249.087910440376, 4316.1151963846705, 4326.610605045561, 4327.480702315742, 4345.934810977901, 5974.581779275582, 5995.95070862606, 5999.820005399845, 6020.668863212565, 6026.608270462406, 5610.438956104357, 5883.323417807007, 5889.469947704727, 5899.764009439575, 5913.349531551612, 5893.0, 5896.204012458435, 5906.852328691817, 5907.675077870586, 5910.408959104056, 5811.157382179645, 5851.5663662402985, 5859.20900678403, 5869.8239052828485, 5924.703764811656, 5693.3168019837885, 5860.443257890493, 5874.735636896265, 5900.380460051632, 5935.376785437467, 5774.220480235114, 5781.0, 5793.913091303718, 5800.230929566523, 5871.0], "value": 4456.759627609682, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.8868958345831, 832.5379414424991, 839.5340585974782, 856.4604299291448, 914.6099515911436, 16361.345546178154, 17937.461876143705, 18025.819741802577, 18175.636487270247, 18338.0, 14699.044562103456, 14788.260586970635, 14824.258787060631, 14885.0, 16217.83782162178, 855.170484629908, 862.8101817600118, 864.2955990867455, 864.6195673903494, 865.4417900454204, 715.1311156944312, 727.5743689941364, 825.8059356051323, 855.6064210463195, 858.3519442820661, 906.0033962641108, 907.2469850024497, 907.5190149220923, 909.2544113826632, 909.5997760985179, 744.4007573903006, 905.0135352465811, 905.2395987370608, 905.5110240470138, 911.1389736698823, 563.5153767759723, 635.0537698828758, 657.9407853293179, 663.8274048747361, 665.6272487407067, 16445.342186312653, 16505.917470412693, 16592.66814663712, 16633.251503682364, 16635.251413686412, 13560.932195339059, 14161.433542658282, 14439.639009024753, 14476.0, 14570.562883113524, 13636.113652612648, 13748.862511374959, 13826.792598111037, 13947.930260348734, 14055.929720351332, 4427.424434823484, 4503.347014682852, 4515.14212299662, 4574.1309151261485, 4600.792964316581, 83319.87357800195, 86494.13505864923, 87069.12930870737, 87281.0, 88361.55819220927, 11442.084633229488, 11674.124440666985, 11683.824742628867, 12087.637370878887, 12135.939320303341, 19392.612147756965, 19396.2241510338, 19399.709004364944, 19402.0, 19408.0, 8307.37694672902, 8342.791430214293, 8357.791055223546, 8674.04585495595, 8703.042665306812, 4913.091078150554, 4998.4251811042195, 5009.5741861941415, 5019.899602007939, 5117.974410128, 3710.9072273193387, 3846.442265871433, 3847.4228865670375, 3848.8845334640005, 3855.7879316637295, 627.4603840696997, 631.2834932351814, 637.1971316141695, 639.7217210513442, 651.8728847874713, 651.1795138125996, 711.7046425733366, 733.1495465260273, 744.6053591596462, 762.7635433015782, 8891.73324800257, 9397.201237894718, 9684.661036863818, 9926.305158638826, 10227.335223210468, 654.5974225851068, 746.4625469661943, 748.1172216784138, 750.6659536506312, 775.7052320118319, 4484.1255955088445, 4783.354247176656, 4794.089123066676, 4797.232442809134, 4824.8793780155775, 133226.0, 135843.32078339742, 139321.0, 140537.0, 148231.0, 68027.65986170038, 91913.5404322974, 92760.0, 120820.39589801995, 121762.0, 56685.0, 58555.70722146447, 84069.57965210258, 90502.0, 92363.95888247255, 8995.775105622412, 9242.445453272825, 9930.652427165014, 10085.647002354883, 10273.589056437957, 41486.377704335064, 46957.0, 51268.230976534636, 53008.46991530035, 56856.43143568511, 52522.0, 53738.46261537335, 60692.69653651703, 71794.0, 79351.0, 13335.599932002055, 13505.32473376347, 13613.591592252249, 14267.07264027835, 14774.409023638935, 14575.927120364755, 16278.837211627731, 16498.457668233783, 16964.406245781338, 17966.820331796516, 14400.927995359956, 14607.269636518344, 14798.926005369904, 15240.847591524387, 15622.453214137451, 14179.361928713439, 14560.053596516193, 15145.091294522364, 15227.923860380628, 15446.30491627857, 13434.93282533581, 14080.78878816798, 14352.995290329576, 14387.92806036005, 14808.25958702082, 11981.700457488283, 12037.097217708531, 12267.815982760087, 12485.875141248835, 12624.053196010153, 11908.166428349932, 12823.230606163661, 12978.58082450145, 13059.542915997894, 13167.144135631153], "value": 7910.3443690977565, "unit": "score"}], "name": "dromaeo_css", "value": 7622.636580647221, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0, 113.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 120.0, 150.0, 118.0, 118.0, 117.0, 117.0, 155.0, 122.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 108.0, 76.0, 75.0, 75.0, 76.0, 99.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 82.0, 82.0, 82.0, 98.0, 81.0, 82.0, 115.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 50.0, 50.0, 50.0, 52.0, 51.0, 51.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 61.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 75.0, 73.0, 73.0, 74.0, 73.0, 73.0, 77.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 136.0, 119.0, 119.0, 118.0, 125.0, 119.0, 164.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 150.0, 151.0, 151.0, 148.0, 152.0, 155.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1454.1999999999998, "alertThreshold": 2.0}]} 15:34:29 INFO - Return code: 0 15:34:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:34:29 INFO - # TBPL SUCCESS # 15:34:29 INFO - Running post-action listener: _resource_record_post_action 15:34:29 INFO - [mozharness: 2016-09-27 22:34:29.167379Z] Finished run-tests step (success) 15:34:29 INFO - Running post-run listener: _resource_record_post_run 15:34:29 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 354705408; Read time: 56; Write time: 407536 15:34:29 INFO - TinderboxPrint: CPU usage
12.9% 15:34:29 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 56 15:34:29 INFO - TinderboxPrint: I/O write bytes / time
354,705,408 / 407,536 15:34:29 INFO - TinderboxPrint: CPU idle
8,274.7 (87.0%) 15:34:29 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 15:34:29 INFO - TinderboxPrint: Swap in / out
0 / 0 15:34:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107544576; Read time: 0; Write time: 156532 15:34:29 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246546432; Read time: 16; Write time: 251004 15:34:29 INFO - Running post-run listener: _upload_blobber_files 15:34:29 INFO - Blob upload gear active. 15:34:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:29 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 15:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:34:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:34:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:31 INFO - (blobuploader) - INFO - Done attempting. 15:34:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:34:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:34 INFO - (blobuploader) - INFO - Done attempting. 15:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:35 INFO - (blobuploader) - INFO - Done attempting. 15:34:35 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:35 INFO - Return code: 0 15:34:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212f02f59f81c74794f83bbd5aeb0e57ad7ba90cf3243d18cda67fe53d4588e05eb24826d2fd6cfacf1a4f52e24f7f8e700e829d9f90b7575f015d936cb78543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7670cb68e9f97b41a257335d16fba432808b9854d5b1f8f3f7df505f0aa772df4da5883ab319e31acaeaa8e8c95f8f9080b67a2cbec12b951aba0f7d70e7cf7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aae3c654c3c90547c369a21c7324f6fc69a22dcb418170b8602728a871b857523a8523d97a68a6abf473a4ff1b9f909a01e3bee05748c7a75df5bbfb27ea5d04"} 15:34:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:35 INFO - Contents: 15:34:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212f02f59f81c74794f83bbd5aeb0e57ad7ba90cf3243d18cda67fe53d4588e05eb24826d2fd6cfacf1a4f52e24f7f8e700e829d9f90b7575f015d936cb78543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7670cb68e9f97b41a257335d16fba432808b9854d5b1f8f3f7df505f0aa772df4da5883ab319e31acaeaa8e8c95f8f9080b67a2cbec12b951aba0f7d70e7cf7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aae3c654c3c90547c369a21c7324f6fc69a22dcb418170b8602728a871b857523a8523d97a68a6abf473a4ff1b9f909a01e3bee05748c7a75df5bbfb27ea5d04"} 15:34:35 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:35 INFO - Copying logs to upload dir... 15:34:35 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.550297 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-27 15:34:35.133634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 15:34:35.137575) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212f02f59f81c74794f83bbd5aeb0e57ad7ba90cf3243d18cda67fe53d4588e05eb24826d2fd6cfacf1a4f52e24f7f8e700e829d9f90b7575f015d936cb78543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7670cb68e9f97b41a257335d16fba432808b9854d5b1f8f3f7df505f0aa772df4da5883ab319e31acaeaa8e8c95f8f9080b67a2cbec12b951aba0f7d70e7cf7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aae3c654c3c90547c369a21c7324f6fc69a22dcb418170b8602728a871b857523a8523d97a68a6abf473a4ff1b9f909a01e3bee05748c7a75df5bbfb27ea5d04"} build_url:https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/RZKMIRrMTraoWRnH3cpK1A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212f02f59f81c74794f83bbd5aeb0e57ad7ba90cf3243d18cda67fe53d4588e05eb24826d2fd6cfacf1a4f52e24f7f8e700e829d9f90b7575f015d936cb78543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7670cb68e9f97b41a257335d16fba432808b9854d5b1f8f3f7df505f0aa772df4da5883ab319e31acaeaa8e8c95f8f9080b67a2cbec12b951aba0f7d70e7cf7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aae3c654c3c90547c369a21c7324f6fc69a22dcb418170b8602728a871b857523a8523d97a68a6abf473a4ff1b9f909a01e3bee05748c7a75df5bbfb27ea5d04"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 15:34:35.165771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:34:35.166486) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1475014439.420820-514660756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 15:34:35.250866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 15:34:35.251622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 15:34:35.252273) ========= ========= Total master_lag: 0.17 =========