builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1474970726.28 results: success (0) buildid: 20160926233345 builduid: f21a289857fd42ba8cccd3e6a6f8ef47 revision: df63260c1c90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.284252) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.284762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.285093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.300349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.300802) ========= 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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 03:05:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-09-27 03:05:27 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084720 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.428402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.428817) ========= 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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020478 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:26.485013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:05:26.485398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df63260c1c90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev df63260c1c90 --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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 03:05:27,389 Setting DEBUG logging. 2016-09-27 03:05:27,389 attempt 1/10 2016-09-27 03:05:27,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df63260c1c90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 03:05:28,209 unpacking tar archive at: fx-team-df63260c1c90/testing/mozharness/ program finished with exit code 0 elapsedTime=1.142893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:05:27.642569) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:27.642911) ========= script_repo_revision: df63260c1c90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:27.643387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:27.643753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:05:27.653265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-27 03:05:27.653592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:28 INFO - MultiFileLogger online at 20160927 03:05:28 in /builds/slave/test 03:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:05:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:05:28 INFO - {'append_to_log': False, 03:05:28 INFO - 'base_work_dir': '/builds/slave/test', 03:05:28 INFO - 'blob_upload_branch': 'Fx-Team', 03:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:05:28 INFO - 'branch': 'Fx-Team', 03:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:28 INFO - 'config_files': ('talos/linux_config.py',), 03:05:28 INFO - 'default_actions': ('clobber', 03:05:28 INFO - 'read-buildbot-config', 03:05:28 INFO - 'download-and-extract', 03:05:28 INFO - 'populate-webroot', 03:05:28 INFO - 'create-virtualenv', 03:05:28 INFO - 'install', 03:05:28 INFO - 'run-tests'), 03:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:28 INFO - 'download_minidump_stackwalk': True, 03:05:28 INFO - 'download_symbols': 'ondemand', 03:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:28 INFO - 'installer_path': 'installer.exe', 03:05:28 INFO - 'log_level': 'info', 03:05:28 INFO - 'log_name': 'talos', 03:05:28 INFO - 'log_to_console': True, 03:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:28 INFO - 'opt_config_files': (), 03:05:28 INFO - 'pip_index': False, 03:05:28 INFO - 'sps_profile': False, 03:05:28 INFO - 'sps_profile_interval': 0, 03:05:28 INFO - 'suite': 'dromaeojs', 03:05:28 INFO - 'system_bits': '32', 03:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:28 INFO - 'title': 'talos-linux64-ix-058', 03:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:28 INFO - 'use_talos_json': True, 03:05:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:28 INFO - 'work_dir': 'build'} 03:05:28 INFO - [mozharness: 2016-09-27 10:05:28.655862Z] Running clobber step. 03:05:28 INFO - Running pre-action listener: _resource_record_pre_action 03:05:28 INFO - Running main action method: clobber 03:05:28 INFO - rmtree: /builds/slave/test/build 03:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:05:29 INFO - Running post-action listener: _resource_record_post_action 03:05:29 INFO - [mozharness: 2016-09-27 10:05:29.121992Z] Finished clobber step (success) 03:05:29 INFO - [mozharness: 2016-09-27 10:05:29.122096Z] Running read-buildbot-config step. 03:05:29 INFO - Running pre-action listener: _resource_record_pre_action 03:05:29 INFO - Running main action method: read_buildbot_config 03:05:29 INFO - Using buildbot properties: 03:05:29 INFO - { 03:05:29 INFO - "project": "", 03:05:29 INFO - "product": "firefox", 03:05:29 INFO - "script_repo_revision": "production", 03:05:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:05:29 INFO - "repository": "", 03:05:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:05:29 INFO - "buildid": "20160926233345", 03:05:29 INFO - "pgo_build": "True", 03:05:29 INFO - "basedir": "/builds/slave/test", 03:05:29 INFO - "buildnumber": 479, 03:05:29 INFO - "slavename": "talos-linux64-ix-058", 03:05:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:05:29 INFO - "platform": "ubuntu64_hw", 03:05:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:05:29 INFO - "branch": "fx-team", 03:05:29 INFO - "repo_path": "integration/fx-team", 03:05:29 INFO - "revision": "df63260c1c90", 03:05:29 INFO - "stage_platform": "linux64-pgo", 03:05:29 INFO - "builduid": "f21a289857fd42ba8cccd3e6a6f8ef47", 03:05:29 INFO - "slavebuilddir": "test" 03:05:29 INFO - } 03:05:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:05:29 INFO - Running post-action listener: _resource_record_post_action 03:05:29 INFO - [mozharness: 2016-09-27 10:05:29.124526Z] Finished read-buildbot-config step (success) 03:05:29 INFO - [mozharness: 2016-09-27 10:05:29.124614Z] Running download-and-extract step. 03:05:29 INFO - Running pre-action listener: _resource_record_pre_action 03:05:29 INFO - Running main action method: download_and_extract 03:05:29 INFO - mkdir: /builds/slave/test/build/tests 03:05: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')]} 03:05:29 INFO - trying https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:05:29 INFO - Downloaded 1361 bytes. 03:05:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:05:29 INFO - Using the following test package requirements: 03:05:29 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:05:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:05:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:05:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'jsshell-linux-x86_64.zip'], 03:05:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:05:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:05:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:05:29 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:05:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:05:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:05:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:05:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:05:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:29 INFO - Fetch https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:05:30 INFO - Expected file size: 21981467 03:05:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:05:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:05:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:34 INFO - Fetch https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:05:35 INFO - Expected file size: 21981467 03:05:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:05:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:05:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:05:40 INFO - Expected file size: 14414057 03:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:40 INFO - trying https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:05:40 INFO - Downloading https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:05:42 INFO - Downloaded 59711164 bytes. 03:05:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:05:42 INFO - mkdir: /builds/slave/test/properties 03:05:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:05:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:05:42 INFO - Contents: 03:05:42 INFO - build_url:https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:05:42 INFO - Running post-action listener: _resource_record_post_action 03:05:42 INFO - Running post-action listener: set_extra_try_arguments 03:05:42 INFO - [mozharness: 2016-09-27 10:05:42.829303Z] Finished download-and-extract step (success) 03:05:42 INFO - [mozharness: 2016-09-27 10:05:42.829529Z] Running populate-webroot step. 03:05:42 INFO - Running pre-action listener: _resource_record_pre_action 03:05:42 INFO - Running main action method: populate_webroot 03:05:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:05:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:05:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:05:42 INFO - '--tppagecycles', 03:05:42 INFO - '7'], 03:05:42 INFO - 'tests': ['tsvgm']}}, 03:05:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:05:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:05:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:05:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:05:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['damp', 'tps']}, 03:05:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'tests': ['damp', 'tps']}, 03:05:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['dromaeo_dom']}, 03:05:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:05:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['basic_compositor_video']}, 03:05:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:05:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['a11yr', 03:05:42 INFO - 'ts_paint', 03:05:42 INFO - 'tpaint', 03:05:42 INFO - 'sessionrestore', 03:05:42 INFO - 'sessionrestore_no_auto_restore', 03:05:42 INFO - 'tabpaint']}, 03:05:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['tsvgx', 03:05:42 INFO - 'tsvgr_opacity', 03:05:42 INFO - 'tart', 03:05:42 INFO - 'tscrollx', 03:05:42 INFO - 'cart']}, 03:05:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:05:42 INFO - 'tsvgr_opacity', 03:05:42 INFO - 'tart', 03:05:42 INFO - 'tscrollx', 03:05:42 INFO - 'cart']}, 03:05:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'talos_options': ['--disable-e10s'], 03:05:42 INFO - 'tests': ['tp5o']}, 03:05:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'tests': ['tp5o']}, 03:05:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'talos_options': ['--disable-e10s', 03:05:42 INFO - '--xperf_path', 03:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:42 INFO - 'tests': ['tp5n']}, 03:05:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:42 INFO - 'talos_options': ['--xperf_path', 03:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:42 INFO - 'tests': ['tp5n']}}, 03:05:42 INFO - 'talos.zip': {'path': '', 03:05:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:05:42 INFO - Running post-action listener: _resource_record_post_action 03:05:42 INFO - [mozharness: 2016-09-27 10:05:42.847236Z] Finished populate-webroot step (success) 03:05:42 INFO - [mozharness: 2016-09-27 10:05:42.847329Z] Running create-virtualenv step. 03:05:42 INFO - Running pre-action listener: _resource_record_pre_action 03:05:42 INFO - Running main action method: create_virtualenv 03:05:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:05:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:05:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:05:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:05:42 INFO - Using real prefix '/usr' 03:05:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:05:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:05:45 INFO - Installing pip.................done. 03:05:45 INFO - Return code: 0 03:05:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:05:45 INFO - Reading from file tmpfile_stdout 03:05:45 INFO - Output received: 03:05:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:05:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:45 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:05:45 INFO - Using env: {'DISPLAY': ':0', 03:05:45 INFO - 'HOME': '/home/cltbld', 03:05:45 INFO - 'LANG': 'en_US.UTF-8', 03:05:45 INFO - 'LANGUAGE': 'en_US:en', 03:05:45 INFO - 'LOGNAME': 'cltbld', 03:05:45 INFO - 'MAIL': '/var/mail/cltbld', 03:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:45 INFO - 'MOZ_NO_REMOTE': '1', 03:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:45 INFO - 'NO_EM_RESTART': '1', 03:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:45 INFO - 'PWD': '/builds/slave/test', 03:05:45 INFO - 'SHELL': '/bin/bash', 03:05:45 INFO - 'SHLVL': '1', 03:05:45 INFO - 'TERM': 'linux', 03:05:45 INFO - 'TMOUT': '86400', 03:05:45 INFO - 'USER': 'cltbld', 03:05:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:45 INFO - '_': '/tools/buildbot/bin/python'} 03:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:05:45 INFO - Cleaning up... 03:05:45 INFO - Return code: 0 03:05:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:45 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:05:45 INFO - Using env: {'DISPLAY': ':0', 03:05:45 INFO - 'HOME': '/home/cltbld', 03:05:45 INFO - 'LANG': 'en_US.UTF-8', 03:05:45 INFO - 'LANGUAGE': 'en_US:en', 03:05:45 INFO - 'LOGNAME': 'cltbld', 03:05:45 INFO - 'MAIL': '/var/mail/cltbld', 03:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:45 INFO - 'MOZ_NO_REMOTE': '1', 03:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:45 INFO - 'NO_EM_RESTART': '1', 03:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:45 INFO - 'PWD': '/builds/slave/test', 03:05:45 INFO - 'SHELL': '/bin/bash', 03:05:45 INFO - 'SHLVL': '1', 03:05:45 INFO - 'TERM': 'linux', 03:05:45 INFO - 'TMOUT': '86400', 03:05:45 INFO - 'USER': 'cltbld', 03:05:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:45 INFO - '_': '/tools/buildbot/bin/python'} 03:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:46 INFO - Downloading/unpacking psutil>=3.1.1 03:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:48 INFO - Installing collected packages: psutil 03:05:48 INFO - Running setup.py install for psutil 03:05:48 INFO - building 'psutil._psutil_linux' extension 03:05:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:05:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:05:48 INFO - building 'psutil._psutil_posix' extension 03:05:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:05:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:48 INFO - Successfully installed psutil 03:05:48 INFO - Cleaning up... 03:05:48 INFO - Return code: 0 03:05:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:48 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:05:48 INFO - Using env: {'DISPLAY': ':0', 03:05:48 INFO - 'HOME': '/home/cltbld', 03:05:48 INFO - 'LANG': 'en_US.UTF-8', 03:05:48 INFO - 'LANGUAGE': 'en_US:en', 03:05:48 INFO - 'LOGNAME': 'cltbld', 03:05:48 INFO - 'MAIL': '/var/mail/cltbld', 03:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:48 INFO - 'MOZ_NO_REMOTE': '1', 03:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:48 INFO - 'NO_EM_RESTART': '1', 03:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:48 INFO - 'PWD': '/builds/slave/test', 03:05:48 INFO - 'SHELL': '/bin/bash', 03:05:48 INFO - 'SHLVL': '1', 03:05:48 INFO - 'TERM': 'linux', 03:05:48 INFO - 'TMOUT': '86400', 03:05:48 INFO - 'USER': 'cltbld', 03:05:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:48 INFO - '_': '/tools/buildbot/bin/python'} 03:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:05:50 INFO - Installing collected packages: mozsystemmonitor 03:05:50 INFO - Running setup.py install for mozsystemmonitor 03:05:50 INFO - Successfully installed mozsystemmonitor 03:05:50 INFO - Cleaning up... 03:05:50 INFO - Return code: 0 03:05:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:50 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:05:50 INFO - Using env: {'DISPLAY': ':0', 03:05:50 INFO - 'HOME': '/home/cltbld', 03:05:50 INFO - 'LANG': 'en_US.UTF-8', 03:05:50 INFO - 'LANGUAGE': 'en_US:en', 03:05:50 INFO - 'LOGNAME': 'cltbld', 03:05:50 INFO - 'MAIL': '/var/mail/cltbld', 03:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:50 INFO - 'MOZ_NO_REMOTE': '1', 03:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:50 INFO - 'NO_EM_RESTART': '1', 03:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:50 INFO - 'PWD': '/builds/slave/test', 03:05:50 INFO - 'SHELL': '/bin/bash', 03:05:50 INFO - 'SHLVL': '1', 03:05:50 INFO - 'TERM': 'linux', 03:05:50 INFO - 'TMOUT': '86400', 03:05:50 INFO - 'USER': 'cltbld', 03:05:50 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:50 INFO - '_': '/tools/buildbot/bin/python'} 03:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:05:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:05:53 INFO - warning: no files found matching '*.txt' 03:05:53 INFO - no previously-included directories found matching 'build' 03:05:53 INFO - no previously-included directories found matching 'dist' 03:05:53 INFO - no previously-included directories found matching '.git*' 03:05:53 INFO - Installing collected packages: jsonschema, functools32 03:05:53 INFO - Running setup.py install for functools32 03:05:53 INFO - warning: no files found matching '*.txt' 03:05:53 INFO - no previously-included directories found matching 'build' 03:05:53 INFO - no previously-included directories found matching 'dist' 03:05:53 INFO - no previously-included directories found matching '.git*' 03:05:53 INFO - Successfully installed jsonschema functools32 03:05:53 INFO - Cleaning up... 03:05:53 INFO - Return code: 0 03:05:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:53 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:05:53 INFO - Using env: {'DISPLAY': ':0', 03:05:53 INFO - 'HOME': '/home/cltbld', 03:05:53 INFO - 'LANG': 'en_US.UTF-8', 03:05:53 INFO - 'LANGUAGE': 'en_US:en', 03:05:53 INFO - 'LOGNAME': 'cltbld', 03:05:53 INFO - 'MAIL': '/var/mail/cltbld', 03:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:53 INFO - 'MOZ_NO_REMOTE': '1', 03:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:53 INFO - 'NO_EM_RESTART': '1', 03:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:53 INFO - 'PWD': '/builds/slave/test', 03:05:53 INFO - 'SHELL': '/bin/bash', 03:05:53 INFO - 'SHLVL': '1', 03:05:53 INFO - 'TERM': 'linux', 03:05:53 INFO - 'TMOUT': '86400', 03:05:53 INFO - 'USER': 'cltbld', 03:05:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:53 INFO - '_': '/tools/buildbot/bin/python'} 03:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:05:53 INFO - Cleaning up... 03:05:53 INFO - Return code: 0 03:05:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:53 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:05:53 INFO - Using env: {'DISPLAY': ':0', 03:05:53 INFO - 'HOME': '/home/cltbld', 03:05:53 INFO - 'LANG': 'en_US.UTF-8', 03:05:53 INFO - 'LANGUAGE': 'en_US:en', 03:05:53 INFO - 'LOGNAME': 'cltbld', 03:05:53 INFO - 'MAIL': '/var/mail/cltbld', 03:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:53 INFO - 'MOZ_NO_REMOTE': '1', 03:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:53 INFO - 'NO_EM_RESTART': '1', 03:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:53 INFO - 'PWD': '/builds/slave/test', 03:05:53 INFO - 'SHELL': '/bin/bash', 03:05:53 INFO - 'SHLVL': '1', 03:05:53 INFO - 'TERM': 'linux', 03:05:53 INFO - 'TMOUT': '86400', 03:05:53 INFO - 'USER': 'cltbld', 03:05:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:53 INFO - '_': '/tools/buildbot/bin/python'} 03:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:56 INFO - Downloading docopt-0.6.1.tar.gz 03:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:56 INFO - Running setup.py install for blobuploader 03:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:56 INFO - Running setup.py install for requests 03:05:57 INFO - Running setup.py install for docopt 03:05:57 INFO - Successfully installed blobuploader requests docopt 03:05:57 INFO - Cleaning up... 03:05:57 INFO - Return code: 0 03:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:57 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:05:57 INFO - Using env: {'DISPLAY': ':0', 03:05:57 INFO - 'HOME': '/home/cltbld', 03:05:57 INFO - 'LANG': 'en_US.UTF-8', 03:05:57 INFO - 'LANGUAGE': 'en_US:en', 03:05:57 INFO - 'LOGNAME': 'cltbld', 03:05:57 INFO - 'MAIL': '/var/mail/cltbld', 03:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:57 INFO - 'MOZ_NO_REMOTE': '1', 03:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:57 INFO - 'NO_EM_RESTART': '1', 03:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:57 INFO - 'PWD': '/builds/slave/test', 03:05:57 INFO - 'SHELL': '/bin/bash', 03:05:57 INFO - 'SHLVL': '1', 03:05:57 INFO - 'TERM': 'linux', 03:05:57 INFO - 'TMOUT': '86400', 03:05:57 INFO - 'USER': 'cltbld', 03:05:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:57 INFO - '_': '/tools/buildbot/bin/python'} 03:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:57 INFO - Running setup.py (path:/tmp/pip-4QwtkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:57 INFO - Running setup.py (path:/tmp/pip-984syF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:57 INFO - Running setup.py (path:/tmp/pip-PM1L4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:57 INFO - Running setup.py (path:/tmp/pip-Y09tlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:57 INFO - Running setup.py (path:/tmp/pip-Tj_zfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:57 INFO - Running setup.py (path:/tmp/pip-abE7Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:57 INFO - Running setup.py (path:/tmp/pip-Opaq8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:57 INFO - Running setup.py (path:/tmp/pip-zF0inO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:58 INFO - Running setup.py (path:/tmp/pip-rntlpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:58 INFO - Running setup.py (path:/tmp/pip-RfDJ1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:58 INFO - Running setup.py (path:/tmp/pip-0Sa9iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:58 INFO - Running setup.py (path:/tmp/pip-FuWMue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:58 INFO - Running setup.py (path:/tmp/pip-fEYtYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:58 INFO - Running setup.py (path:/tmp/pip-e0DH_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:58 INFO - Running setup.py (path:/tmp/pip-58G9OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:58 INFO - Running setup.py (path:/tmp/pip-WWj7v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:58 INFO - Running setup.py (path:/tmp/pip-o08HWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:58 INFO - Running setup.py install for manifestparser 03:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:58 INFO - Running setup.py install for mozcrash 03:05:58 INFO - Running setup.py install for mozdebug 03:05:59 INFO - Running setup.py install for mozdevice 03:05:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for mozfile 03:05:59 INFO - Running setup.py install for mozhttpd 03:05:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for mozinfo 03:05:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for mozInstall 03:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for mozleak 03:05:59 INFO - Running setup.py install for mozlog 03:05:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for moznetwork 03:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:59 INFO - Running setup.py install for mozprocess 03:05:59 INFO - Running setup.py install for mozprofile 03:06:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:00 INFO - Running setup.py install for mozrunner 03:06:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:00 INFO - Running setup.py install for mozscreenshot 03:06:00 INFO - Running setup.py install for moztest 03:06:00 INFO - Running setup.py install for mozversion 03:06:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:00 INFO - Cleaning up... 03:06:00 INFO - Return code: 0 03:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:00 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:06:00 INFO - Using env: {'DISPLAY': ':0', 03:06:00 INFO - 'HOME': '/home/cltbld', 03:06:00 INFO - 'LANG': 'en_US.UTF-8', 03:06:00 INFO - 'LANGUAGE': 'en_US:en', 03:06:00 INFO - 'LOGNAME': 'cltbld', 03:06:00 INFO - 'MAIL': '/var/mail/cltbld', 03:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:00 INFO - 'MOZ_NO_REMOTE': '1', 03:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:00 INFO - 'NO_EM_RESTART': '1', 03:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:00 INFO - 'PWD': '/builds/slave/test', 03:06:00 INFO - 'SHELL': '/bin/bash', 03:06:00 INFO - 'SHLVL': '1', 03:06:00 INFO - 'TERM': 'linux', 03:06:00 INFO - 'TMOUT': '86400', 03:06:00 INFO - 'USER': 'cltbld', 03:06:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:00 INFO - '_': '/tools/buildbot/bin/python'} 03:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:00 INFO - Running setup.py (path:/tmp/pip-DEqZ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:00 INFO - Running setup.py (path:/tmp/pip-D0BtrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:00 INFO - Running setup.py (path:/tmp/pip-fZRZcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:00 INFO - Running setup.py (path:/tmp/pip-ZxtbDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:01 INFO - Running setup.py (path:/tmp/pip-kbj6ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:01 INFO - Running setup.py (path:/tmp/pip-nax7WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:01 INFO - Running setup.py (path:/tmp/pip-KJru5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:01 INFO - Running setup.py (path:/tmp/pip-bbfosb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:01 INFO - Running setup.py (path:/tmp/pip-8C7BUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:01 INFO - Running setup.py (path:/tmp/pip-Tg9ucp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:01 INFO - Running setup.py (path:/tmp/pip-XjOTKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:01 INFO - Running setup.py (path:/tmp/pip-OJuMPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:01 INFO - Running setup.py (path:/tmp/pip-jYm1Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:01 INFO - Running setup.py (path:/tmp/pip-56DE5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:01 INFO - Running setup.py (path:/tmp/pip-jyinr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:01 INFO - Running setup.py (path:/tmp/pip-O4knOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:01 INFO - Running setup.py (path:/tmp/pip-uQ_yZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:03 INFO - Downloading blessings-1.6.tar.gz 03:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:03 INFO - Installing collected packages: blessings 03:06:03 INFO - Running setup.py install for blessings 03:06:04 INFO - Successfully installed blessings 03:06:04 INFO - Cleaning up... 03:06:04 INFO - Return code: 0 03:06:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:04 INFO - Reading from file tmpfile_stdout 03:06:04 INFO - Current package versions: 03:06:04 INFO - argparse == 1.2.1 03:06:04 INFO - blessings == 1.6 03:06:04 INFO - blobuploader == 1.2.4 03:06:04 INFO - docopt == 0.6.1 03:06:04 INFO - functools32 == 3.2.3-2 03:06:04 INFO - jsonschema == 2.5.1 03:06:04 INFO - manifestparser == 1.1 03:06:04 INFO - mozInstall == 1.12 03:06:04 INFO - mozcrash == 0.17 03:06:04 INFO - mozdebug == 0.1 03:06:04 INFO - mozdevice == 0.48 03:06:04 INFO - mozfile == 1.2 03:06:04 INFO - mozhttpd == 0.7 03:06:04 INFO - mozinfo == 0.9 03:06:04 INFO - mozleak == 0.1 03:06:04 INFO - mozlog == 3.4 03:06:04 INFO - moznetwork == 0.27 03:06:04 INFO - mozprocess == 0.23 03:06:04 INFO - mozprofile == 0.28 03:06:04 INFO - mozrunner == 6.12 03:06:04 INFO - mozscreenshot == 0.1 03:06:04 INFO - mozsystemmonitor == 0.3 03:06:04 INFO - moztest == 0.7 03:06:04 INFO - mozversion == 1.4 03:06:04 INFO - psutil == 3.1.1 03:06:04 INFO - requests == 1.2.3 03:06:04 INFO - wsgiref == 0.1.2 03:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:04 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 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:06:04 INFO - Using env: {'DISPLAY': ':0', 03:06:04 INFO - 'HOME': '/home/cltbld', 03:06:04 INFO - 'LANG': 'en_US.UTF-8', 03:06:04 INFO - 'LANGUAGE': 'en_US:en', 03:06:04 INFO - 'LOGNAME': 'cltbld', 03:06:04 INFO - 'MAIL': '/var/mail/cltbld', 03:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:04 INFO - 'MOZ_NO_REMOTE': '1', 03:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:04 INFO - 'NO_EM_RESTART': '1', 03:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:04 INFO - 'PWD': '/builds/slave/test', 03:06:04 INFO - 'SHELL': '/bin/bash', 03:06:04 INFO - 'SHLVL': '1', 03:06:04 INFO - 'TERM': 'linux', 03:06:04 INFO - 'TMOUT': '86400', 03:06:04 INFO - 'USER': 'cltbld', 03:06:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:04 INFO - '_': '/tools/buildbot/bin/python'} 03:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:06:04 INFO - Cleaning up... 03:06:04 INFO - Return code: 0 03:06:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35397d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ab7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, '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': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:06:04 INFO - Using env: {'DISPLAY': ':0', 03:06:04 INFO - 'HOME': '/home/cltbld', 03:06:04 INFO - 'LANG': 'en_US.UTF-8', 03:06:04 INFO - 'LANGUAGE': 'en_US:en', 03:06:04 INFO - 'LOGNAME': 'cltbld', 03:06:04 INFO - 'MAIL': '/var/mail/cltbld', 03:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:04 INFO - 'MOZ_NO_REMOTE': '1', 03:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:04 INFO - 'NO_EM_RESTART': '1', 03:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:04 INFO - 'PWD': '/builds/slave/test', 03:06:04 INFO - 'SHELL': '/bin/bash', 03:06:04 INFO - 'SHLVL': '1', 03:06:04 INFO - 'TERM': 'linux', 03:06:04 INFO - 'TMOUT': '86400', 03:06:04 INFO - 'USER': 'cltbld', 03:06:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:04 INFO - '_': '/tools/buildbot/bin/python'} 03:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:06:04 INFO - Cleaning up... 03:06:04 INFO - Return code: 0 03:06:04 INFO - Running post-action listener: _resource_record_post_action 03:06:04 INFO - Running post-action listener: _start_resource_monitoring 03:06:04 INFO - Starting resource monitoring. 03:06:04 INFO - [mozharness: 2016-09-27 10:06:04.842176Z] Finished create-virtualenv step (success) 03:06:04 INFO - [mozharness: 2016-09-27 10:06:04.842769Z] Running install step. 03:06:04 INFO - Running pre-action listener: _resource_record_pre_action 03:06:04 INFO - Running main action method: install 03:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:05 INFO - Reading from file tmpfile_stdout 03:06:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:06:05 INFO - Reading from file tmpfile_stdout 03:06:05 INFO - Output received: 03:06:05 INFO - Usage: mozinstall [options] installer 03:06:05 INFO - Options: 03:06:05 INFO - -h, --help show this help message and exit 03:06:05 INFO - -d DEST, --destination=DEST 03:06:05 INFO - Directory to install application into. [default: 03:06:05 INFO - "/builds/slave/test"] 03:06:05 INFO - --app=APP Application being installed. [default: firefox] 03:06:05 INFO - mkdir: /builds/slave/test/build/application 03:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:06:22 INFO - Reading from file tmpfile_stdout 03:06:22 INFO - Output received: 03:06:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:06:22 INFO - Running post-action listener: _resource_record_post_action 03:06:22 INFO - [mozharness: 2016-09-27 10:06:22.190945Z] Finished install step (success) 03:06:22 INFO - [mozharness: 2016-09-27 10:06:22.191191Z] Running run-tests step. 03:06:22 INFO - Running pre-action listener: _resource_record_pre_action 03:06:22 INFO - Running main action method: run_tests 03:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:06:22 INFO - Python 2.7.3 03:06:22 INFO - Return code: 0 03:06:22 INFO - grabbing minidump binary from tooltool 03:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:22 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 0x133a790>, '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 0x133b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:06:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:06:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:06:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:06:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:22 INFO - Return code: 0 03:06:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:06:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:06:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:06:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:06:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:06:22 INFO - Using env: {'DISPLAY': ':0', 03:06:22 INFO - 'HOME': '/home/cltbld', 03:06:22 INFO - 'LANG': 'en_US.UTF-8', 03:06:22 INFO - 'LANGUAGE': 'en_US:en', 03:06:22 INFO - 'LOGNAME': 'cltbld', 03:06:22 INFO - 'MAIL': '/var/mail/cltbld', 03:06:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:22 INFO - 'MOZ_NO_REMOTE': '1', 03:06:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:22 INFO - 'NO_EM_RESTART': '1', 03:06:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:22 INFO - 'PWD': '/builds/slave/test', 03:06:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:22 INFO - 'SHELL': '/bin/bash', 03:06:22 INFO - 'SHLVL': '1', 03:06:22 INFO - 'TERM': 'linux', 03:06:22 INFO - 'TMOUT': '86400', 03:06:22 INFO - 'USER': 'cltbld', 03:06:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259', 03:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:22 INFO - '_': '/tools/buildbot/bin/python'} 03:06:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:06:22 INFO - mozversion application_buildid: 20160926233345 03:06:22 INFO - mozversion application_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 03:06:22 INFO - mozversion application_display_name: Nightly 03:06:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:22 INFO - mozversion application_name: Firefox 03:06:22 INFO - mozversion application_remotingname: firefox 03:06:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:06:22 INFO - mozversion application_vendor: Mozilla 03:06:22 INFO - mozversion application_version: 52.0a1 03:06:22 INFO - mozversion platform_buildid: 20160926233345 03:06:22 INFO - mozversion platform_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 03:06:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:06:22 INFO - mozversion platform_version: 52.0a1 03:06:22 INFO - using testdate: 1474970782 03:06:22 INFO - actual date: 1474970782 03:06:22 INFO - starting webserver on 'localhost:43512' 03:06:22 INFO - SUITE-START | Running 2 tests 03:06:22 INFO - TEST-START | dromaeo_css 03:06:22 INFO - operating with platform_type : linux_ 03:06:22 INFO - Initialising browser for dromaeo_css test... 03:06:22 INFO - TEST-INFO | started process 4061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaPQM4A/profile http://localhost:43512/getInfo.html) 03:06:26 INFO - PROCESS | 4061 | __metrics Screen width/height:1600/1200 03:06:26 INFO - PROCESS | 4061 | colorDepth:24 03:06:26 INFO - PROCESS | 4061 | Browser inner width/height: 1024/697 03:06:26 INFO - PROCESS | 4061 | __metrics 03:06:27 INFO - PROCESS | 4061 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:06:27 INFO - PROCESS | 4061 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:06:28 INFO - PROCESS | 4061 | console.error: PushService: 03:06:28 INFO - PROCESS | 4061 | stateChangeProcessEnqueue: Error transitioning state 03:06:28 INFO - PROCESS | 4061 | UnknownError 03:06:28 INFO - TEST-INFO | 4061: exit 0 03:06:28 INFO - Browser initialized. 03:06:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:06:28 INFO - TEST-INFO | started process 4145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaPQM4A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:40 INFO - PROCESS | 4145 | RSS: Main: 174080000 03:06:40 INFO - PROCESS | 4145 | 03:07:31 INFO - PROCESS | 4145 | 1474970851867 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:09:42 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43512/tests/dromaeo/cssquery-ext.html) 03:09:43 INFO - PROCESS | 4145 | RSS: Main: 286765056 03:09:43 INFO - PROCESS | 4145 | 03:12:45 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-ext.html (next: http://localhost:43512/tests/dromaeo/cssquery-jquery.html) 03:12:46 INFO - PROCESS | 4145 | RSS: Main: 277573632 03:12:46 INFO - PROCESS | 4145 | 03:15:48 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43512/tests/dromaeo/cssquery-mootools.html) 03:15:48 INFO - PROCESS | 4145 | RSS: Main: 217026560 03:15:48 INFO - PROCESS | 4145 | 03:18:51 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43512/tests/dromaeo/cssquery-prototype.html) 03:18:51 INFO - PROCESS | 4145 | RSS: Main: 270749696 03:18:51 INFO - PROCESS | 4145 | 03:21:54 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43512/tests/dromaeo/cssquery-yui.html) 03:21:54 INFO - PROCESS | 4145 | RSS: Main: 216219648 03:21:54 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | Cycle 1(1): loaded http://localhost:43512/tests/dromaeo/cssquery-yui.html (next: http://localhost:43512/tests/dromaeo/cssquery-dojo.html) 03:24:57 INFO - PROCESS | 4145 | RSS: Main: 313790464 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | __start_tp_report 03:24:57 INFO - PROCESS | 4145 | _x_x_mozilla_page_load 03:24:57 INFO - PROCESS | 4145 | _x_x_mozilla_page_load_details 03:24:57 INFO - PROCESS | 4145 | |i|pagename|runs| 03:24:57 INFO - PROCESS | 4145 | |0;dojo.html;2983.492806222942;3010.1270631516863;3022.8639711212995;3053.694630536948;3076.953845692315;5117.974410127954;5200.427952925175;5257.185136303874;5266.236395722623;5303.920441193381;5280.683159010462;5289.788408463666;5336.146216605344;5338.172583249602;5364.061289274371;4799.928001079987;4818.566329030386;4836.733979631119;4849.903001939959;4931.926021109668;4937.432195297551;4956.5043495650325;4973.353464049668;4973.5772459340815;4975.676581022222;4765.380500534909;4802.735849528274;4813.542713442217;4911.091448082098;4922.876928076791;4851.126797176506;4859.975700121477;4861.854144375674;4862.124817532878;4862.878428039292;4816.349792777965;4832.975835120802;4833.936533962523;4839;4840.757962101916;5263.368395792491;5308.92036619451;5312.6281160318795;5315.867103322409;5319.627626066177;5649.774009039634;5652.349979752299;5653.236813030229;5654.46282603152;5662.971685141589;5638.436156384329;5649.378568357477;5672.205891175238;5676.687782171979;5677.57418193633;5180.4042535108565;5198.298229738974;5225.085610018232;5232.450592687789;5235.319408476912;5821.883562328814;5828.604785768423;5833.241678581842;5834.766609335664;5835.533157347402;5435.701036443033;5480.725963701799;5525.281713377235;5550.972245138749;5611.859703507445;5625.268715067015;5638.802641907513;5643.887122257614;5655.1799989001365;5704.686242256716;5663.065594176997;5675.233843431167;5676.517496012802;5677.460641239076;5680.602357834912;5586.16207568868;5597.104463285855;5634.577406694514;5643.689597072201;5653.858653533613;4429.955700443019;4430.424044874146;4477.820887164542;4478.529754375809;4482.036362182146;3918.490596222473;3941.0344465605535;3951.4270430787374;3961.425593288957;4000.6199411055904;5287.4976877196605;5322;5365.275687782178;5422.15956526739;5496.1755736639825;5673.858153546194;5702.857428564236;5704.71476426177;5739.942600574024;5767.480926716532;5409.6483728558305;5412.404635490093;5432.348118225838;5442.564594832404;5443.129099344086;4763.214069678534;4856.975715121402;4941.45643979162;4945.455999840015;4994.300797888299;5800.100984347433;5815.040518314515;5824.883502330014;5828.125781132864;5880.705964701662;5764.106563482667;5774.769009239583;5778.913316300175;5782.1615865698395;5791.102379131242;5881.738767271089;5911.852203694942;5915.970420147872;5919.348871624204;5937.287525496968;5549.250851135045;5590.189422533791;5615.298087739033;5626.409227031103;5634.887302254014;5564.276644036249;5622.072358060874;5641.661500309994;5688.54491640676;5695.430456954271;5526.944730552643;5581.13492408661;5583.720813959367;5588.497035266845;5632.802851900164;5468.644538105011;5500.9273191727225;5513.944860551504;5518.117101263779;5525.613207075467;5396.433374495621;5447.727613619224;5451.64564303319;5511.035568775368;5570.888582228252;5571.721413929206;5583.497485226349;5584.385717570983;5631.577631677723;5647.717614119196;5356.839294821161;5359.410464848941;5406.0809662356705;5423.186522021729;5444.50999410055 03:24:57 INFO - PROCESS | 4145 | |1;ext.html;560.9248419345064;583.8073435766196;593.4214141212321;607.5048835199309;608.5922431970579;43734.12531749367;45095.54904450954;45205.32192017118;45209;48410.27384589234;46504.767476162655;46886;46904.66786983765;46987.295190572084;47076.29385559211;9027.909720902806;9149.451032938045;9182.632694692204;9185.908140918606;9186.265098792113;8897.599608017656;8936.32977526688;9003.684871029514;9025.368224224307;9030.774230644221;8938.240249578794;9020.45877247364;9025.458472491639;9065.093490650916;9066.501342426163;8897.421667591585;8961.193492585666;8965.910340896573;8993.77515562113;9002.819943601156;8931.955340223258;9010.86483702745;9046.3667543272;9068.138526839939;9073.63705451781;42072.57927420748;42295;42412.57587424117;42426.57573424257;42528.149437011394;3188.7449004079617;3189.1070500259966;3234.4151365830808;3502.492138639883;3554.413521768905;31735.206619834687;32151.356972860412;32174.356512869846;32181;32914;4296.871093867189;4328.761918094535;4337.783110844477;4345.348197770328;4422.270325396305;337269;337282;338974;339409;339466.30266848754;58939.11591326133;59183.40816591865;59279.40720592739;59347.70326148342;59394;36357.81821090878;37156.25687486235;37358.626413736056;62536.687316563126;62548.687256563426;14417.78373324401;14524.201168935599;14570.63573410652;14571.562853114423;14576.562703118923;10679.786404272027;10749.193810464247;10773.676789696321;10773.730656733644;10780.94609526963;19254.903725481563;19450.902745486183;19460.90269548643;19463.708044379346;19476.4157075288;7224.030837444293;7333.779986600411;7337.669804858688;7354.889676654854;7541.660625271876;928.2991341537096;960.6205548808322;981.9803603928025;983.1839573154265;1063.4257500949554;31497.52753708696;31718.682813172036;31766.841165794023;31846.522302165486;31950.367975243462;1085.1427372375892;1126.2397881430002;1126.7690123524658;1135.7728454309172;1176.2295696318924;15864.098848067468;16785.91607041957;16940.91529542369;17022.148892555324;17271.56821079483;533606;539932;540691;540864;541695;57347;57523;58203.70898145567;58259.12611310834;58262;1195.1633856300625;1241.30486927321;1291.799771035491;1318.7032917593465;1328.1367111377488;28716.42567148687;32346.676533234368;32488.837555813014;32834.13928909774;32999.34001320008;50290.49709503005;50909.23636145535;50935.235971461196;50943.49056509536;50962.490375095775;396988;397246;397393;397479;397943;27649.585256221577;28498.14762040461;28622.570661439677;28784.856075719486;29686.257843554085;46208.53791462042;46684.76657616826;46831.29753053639;47202;47455.52544474511;39612.80193599014;39892.40161397639;40078.58154330964;41053;41782;39122.608773911896;39411.1177764454;40661.79669101635;40847.1830563393;41689;39499.60500395074;39654;39897.2020559593;40279.3958090623;41482;33011.66988330086;36133.63866361408;36661.45007824938;36676;36901.44647830231;27888.302792430353;28196.85901570479;28213;28263.2934176639;28604.42791144207 03:24:57 INFO - PROCESS | 4145 | |2;jquery.html;372.74466990111756;392.5074032089729;394.73552719677804;403.0829862063805;423.48123548652904;13392.464301427943;15667.981581197228;17394.652106957852;19644;20247.392578222676;18391.632167356678;18738.43784686458;19040.71438928417;19094.809051909477;19290;5553.583481238903;5601.523870471015;5824.621399609033;5826.941730582682;5828.795992140276;5640.520555752745;5705;5726.942730572703;5737.684427356494;5743.282089738783;5538.6122971392015;5698.344690360599;5708.372079071299;5708.714564271791;5711.2575365202465;5776.249087618604;5924.259467566554;5941.673207973559;5943.851403714899;5945.256842894638;5615.831525054255;5736.541076713853;5769.538436925036;5770.9422905770825;5778.711064446761;14206.147631142165;14307.57077287683;14416.63958401038;14425.134491930517;14432.639184020378;2077.3248694174454;2113.841461890349;2153.6554151335868;2384.248961577098;2939.8236105833503;9112.088791120901;9299.6898115008;9665.951670241675;9987.051230133126;14327.212003339811;1749.8775085744003;1815.0833828916445;1867.8785878917827;1888.2730148892638;1918.932837350686;79993.00069993013;80029.59985200095;80954;84117.57941210316;84643.57678211569;10880.347179169275;11046.502907369188;11054.557817687202;11168.329900206014;11220.382878941737;15370.538883833502;15394.846051539565;15507.612309692347;15515.146666933428;15571.299291531908;7229.664717637397;7322.267773222635;7347.7795666130105;7457.7016919323705;7467.439942004371;6586.1438013058;6657.533972621967;6826.044353790473;6988.44092472601;7161.283871612901;4707.693999889996;4756.500567440438;4845.152098382769;4848.272759086095;4947.65366424354;1901.8288354048202;1950.2199120351688;1951.2877799603043;1986.4934441717269;2027.8174964253287;853.6585365853584;920.8250432417819;923.8475651517424;1047.5495536919198;1071.287593750163;17533.77263591562;19114.71327930082;19118.33085841989;19227;19233.711494327596;948.7960088580988;953.2231231546267;953.7472569769017;967.8983706710694;973.2651847854825;9838.950805246071;10821.188410869216;10837.078848297982;10862.72843178911;10875.510602022929;422849;441974;459173;460542;461274;87804;88193.55903220571;88419.71592982773;91352;91532.81241407593;980.367662857453;997.8054279415444;1016.7102375822855;1019.8368261078192;1024.032289486443;16310.918445407697;16769.496915092568;17221;17227.569310767332;17256.482305530855;29174.41651167007;32854.507182391804;37116.072098197765;41422.58577414187;42550;54923.450765493435;55149;55373.44626553844;55791;56256;8237.917620823955;8311.6675332986;8446.155384461505;8515.105913878953;8580.59978006087;10595.576176952836;12788;12832.55086071983;13006.80489792635;13219.339033048116;10554.894451055392;10775.838362424412;11053;11171.106311494897;11536.826947595624;10616.84074738895;10795.460226988462;11256.831147532957;11287.717807054889;11456.083513318748;6163.19878415803;8481.194286542768;10358.896411036094;10938.234323597271;11328.376939268419;8224.095349511668;8334.541600212047;8386.161383861809;8442.113578074459;8684.435511691972;9825;10449.58201671955;10658.307210031324;10962.671119866416;11330.433478326215 03:24:57 INFO - PROCESS | 4145 | |3;mootools.html;1316.3615646411483;1413.8515455877132;1445.3495926832925;1543.3055125193666;1723.8879472834265;7652.426068044898;8699.304055675546;9009.099090090987;9018.36871419;9129.95435022824;8938.776530586721;8986.37095403322;9008.09919008099;9012.639494420215;9014.729558113268;2370.3481542575755;2394.1022116706235;2402.0872068613903;2406.266088842911;2406.5908795504806;2343.4024323797407;2399.1363109280646;2418.842775219614;2419.3830573203895;2419.5160967806423;2323.546908352872;2348.2602980061224;2350.6239001759723;2357;2362.83460157789;2333.9183128590416;2353.5881220786378;2363.3146387547677;2363.95272094558;2389.2712722619594;2294.3919861236786;2327.44141406063;2349.741528431888;2350.717913850332;2359.315798418457;7878.606069696492;8140.674373025072;8993.010768815426;9131.589078491485;9184.265258779282;5226.843194704165;5382.515573598355;5384.596155288369;5481.5340696040885;5487.204355368449;3447.276072024878;3503.544539209912;3511.543499345069;3526.488659144435;3563.465480177994;1121.601831349867;1126.0653657464286;1136.8692600350983;1151.205668089016;1157.8321143434239;12567.748645027048;12655.873441265561;12727.23636581808;12783.29691866947;12785.488580456771;4543.204939135704;4690.319903613957;4827.789519969181;4885.218365061573;4893.559579637849;10163.593456261668;10163.644272450429;10178.287519873686;10180.643677471253;10185.898141018642;5336.226247194213;5380.78476860929;5398.64908780928;5409.459054094637;5429.131338985743;4829.27560865873;4932.408111026628;4953.7275449849885;4972.477889821589;4979.701217926936;3807.428885667172;3831.980840095782;3901.49280593521;3905.207776439859;3954.209158168378;1146.873843877173;1148.7472755993667;1168.3690806964314;1186.6202815099086;1188.8751681073363;827.6317038917624;932.5011119051275;935.8034812689411;958.8513780364054;979.647326962293;5945.137954996588;5984.3417224105315;6057.363976782374;6264.874702506016;6372.330905254974;440.66729619137345;449.03681602961467;450.5314472948097;450.63498566161513;452.8256621200861;3857.9614203858164;4179.791010449465;4187.497500299984;4271.722338048017;4275.3800698898485;10092.949535252423;10407.895921040692;10840.457977101114;11226.438678066064;11280.887191128148;11216.775664486664;11236.381998990135;11246.212765106528;11261.549538018551;11304.265222760494;7203.567785932861;7456.664450099867;7457.291557302047;8335.54154521495;8475.915240847637;5627.971860140837;5809.448102430262;5880.8235752927485;5962.9105563415715;6246.344133865879;10127;10201.642942496977;10266.486675666336;10367;10383.2212584055;10381.732787049246;10447.68656940293;10547.630832920811;10562.419066951392;10663.946680266548;7179.8564028720175;7227;7236.131664200329;7274.054372931485;7274.96362518184;8244.29923456513;8257.628406721591;8287.046989596274;8330.958345208235;8341.16588341161;7325.157606875277;7591.430642701709;7673.117591477052;7721;7967.163447837894;7600.2779735925;7603.279455614368;7661.502002369828;7704.6918123274445;7829.334506566778;7285.854282914206;7306.488545801955;7365.300296471826;7367.115946086504;7370.96314518424;5205.6616319939085;5257.158854583248;5400.513953744182;5407.134858422633;5415.4313797050745;5349.732513374238;5376.1398176291605;5387.111126664056;5401.756920938488;5482.753276102505 03:24:57 INFO - PROCESS | 4145 | |4;prototype.html;321.437484402296;331.79262960649595;334.90790032741006;340.38390513171146;341.2696828786397;5028.572571331432;5124.641275110744;5148.304978827857;5235.361423810453;5261.921071183935;4973.428055773587;5110.565601923841;5132.024170694282;5146.5625421839095;5173.870653233671;4057.7159598828093;4115.938260926088;4120.381942708587;4132.938005929914;4134.4856871659;3890.455336252927;4091.5499295077516;4110.671146308303;4131.938020929689;4138.3999320098565;4091;4097.160082183145;4099.692523060782;4100.241455330758;4104.466419365478;4085.428040074392;4087;4092.877213683594;4104.774237416956;4125.23683118621;3574.4995700601935;3679.521662183899;3689.3543629864666;3700.278445703089;3710.8144592770254;5088.77100530477;5114.872128196787;5117.1556693145585;5121.359830021247;5135.768890399941;4722.5513576210205;4727.45634252062;4730.574248317668;4749.26386410107;4749.667523273372;5129.204973229155;5313.734313284321;5394.595405344576;5474.178873169017;5484.424135465799;3962.3858301962955;3965.8810235692686;3975.7813320267373;3985.8405663773415;4015.156817068419;5639.915401268984;5649.12438572022;5650.067738823089;5660.801871934463;5663.969776169771;3856.5757766645647;4044.292248856438;4093.836246550164;4109.568495308009;4128.566500517402;4102.897427564275;4103.7948102594755;4105.4662893823615;4122.8456032311005;4159.441943204907;4646.558576935186;4660.7436590987145;4689.780657029129;4696.154692155376;4697.496801023708;5197.870053248699;5457.508824205761;5467.152591348347;5489.890202195934;5498.80754173602;1418.2341535570677;1438.388684808973;1440.5678296511005;1440.985590144085;1444.1335198880588;913.6665117232162;935.5088578496344;946.6024269806697;946.98199435607;956.6938579654444;4672.275797251432;4711.269753188261;4719.504452032487;4730.2431610942085;4767.69010014348;4911.287863259879;4924.409070911442;4939.456659767423;4955.306257124005;4986.177280748636;4712.232912657753;4738.763061846894;4751.47952655147;4798.688085274446;4956.231784073474;2890.8843646254336;2959.496885529465;2960.2155428811384;2964.777641676883;2975;5749.039244788937;5751.792123653996;5760.452756988079;5761.337446193657;5770.653760774367;5593.552515798727;5696.601237913389;5719.685417302088;5741.684207368551;5749.04532458966;5755.366909639936;5777.566682498746;5781.889610292129;5792.987646423836;5793.333766616809;5392.595555333287;5500;5568.777248909998;5574.191742197439;5587.580931430078;5535.11438169907;5552.69460179694;5563.721813909207;5568.303962004749;5568.693721845338;5696.401877802771;5744.167095771007;5759.56803239767;5799.086301520572;5807.186993820953;3777.527809023872;3871.264459752638;3911.5110611173604;3936.2717897189114;3939.5666476688116;5515.944840551543;5544.916826247529;5547.667139971614;5548.500634942875;5558.499735023867;5430.429804870431;5434.2935418395355;5450.5367043801725;5454.400015998158;5461.754221059982;5191.74041297926;5408.78364865401;5417.377001644703;5423.728813559385;5430.728463576885;5376.274202982548;5386.380566234933;5396.811111611075;5414.377346605191;5415.891682166413;5217.765200566059;5401.918971215357;5413.648112872651;5421.536185230045;5460.208269800936;5343.492368225168;5371.516563509303;5386.13821788512;5396.595255355785;5399.325084364455 03:24:57 INFO - PROCESS | 4145 | |5;yui.html;707.734599525178;710.5772065620957;771.1440301265594;774.337941060393;826.7933016745814;15091.924540377297;15499.767503487457;15529.456469023586;15672.29474673641;15698.92150539247;14953.327100280487;15151.166685832275;15156;15159.6968060639;15167.62080947977;774.6514068669107;795.5187111797366;798.8282519258358;799.3125911715948;799.5362689639995;788.286600626434;789.9052113746359;790.4545863354267;791.6595863778573;791.9683212671487;836.0552575589576;844.0335815491259;844.2823599940033;849.6134258912211;850.4047166983106;845.6321500147425;845.6575087089739;846.2045677063571;846.221476241859;846.2299307630088;623.8783437229743;623.9937600624027;624.4504835744516;624.7969409941787;624.8219257511632;14276.500322488662;14279.643008924757;14285.357158927873;14304.356303966346;14309.78535321971;12304.692382690504;12566.371681415983;12733.25688414968;12793.168444051107;13197.736045279136;11080.16650196148;11260.54957801687;11286.887131128666;11566.248193867372;11593.362365070003;3424.417848965682;3487.5640544931885;3503.9299214015577;3526.6825985661158;3552.1119720069983;78898;80048.59975700143;80253.59873200655;81052.59473702652;81563;8597.5701214939;8718.346124040723;8768.123187681182;9364.765880853032;9502.524873756423;20144.39566812998;20424.285150019678;20515.589688206153;20632.58734825295;20634;7895.328897043815;8207.261346478846;8276.503409795432;8404.957975210085;8834;4700.670953033323;4752.453467851172;4847.781849816767;4865.513448655106;4917.311576379309;3509.596396414394;3588.69496092835;3640.3265395901844;3643.307771523402;3643.872464463731;586.0974099886128;600.9008513595207;609.1715267236555;611.3153268339488;630.6153246519619;653.6568301641677;666.4568376772914;682.7405585877335;686.1491750229679;691.180950573572;8752.474851508803;9066.592003359865;9379.671711490066;9383.202427793578;9672.806543869083;552.3068548971015;577.2265164679266;611.9963260253188;644.8065580325978;653.7221680785647;3828.8659896904032;4116.608922152391;4162.458880345596;4441.089576636847;4446.5331140230455;86715.56642216875;126223.368883155;127304.36347818201;128346;128942;69920;105451;106235.46882265694;108057.4597127025;109483;84790.1520984807;92176.53911730398;93221.5338923301;96454.03545964451;96658.51670741601;8730.825383492422;8827.117288271122;8876.644934202817;9062.546872656472;9387.812243755223;49814.51298409077;50148.498515014384;50478.49521504738;52255.81953443639;52652.47347526476;64210.357896420435;64756;66724.66289691154;75456.24543754492;76924;11657.067434605042;11882.940585297018;11959.222650528036;11980.64058078259;12235.204711693712;13843.653908652364;14453.855461445251;14887.181205033827;14907.478238261609;15025.248737562859;12265.816012759995;12533.686657833627;12623.93688031554;12816.295103769009;13078.80381794293;13726.036391854337;14326.928365358106;14402.855971440571;14588.635284117558;15018.399264029316;11841.703957401134;12079.879201207876;13118.344082796013;13730.862691373359;14185.606910757726;9829.627779165627;9972.351797133164;10259.897401025893;10345.637902673672;10633.946830266108;9696.70909872705;10002.199824013916;10509.475023103583;11513.712157196138;12168.452419641315 03:24:57 INFO - PROCESS | 4145 | __end_tp_report 03:24:57 INFO - PROCESS | 4145 | __start_cc_report 03:24:57 INFO - PROCESS | 4145 | _x_x_mozilla_cycle_collect,912 03:24:57 INFO - PROCESS | 4145 | __end_cc_report 03:24:57 INFO - PROCESS | 4145 | __startTimestamp1474971897762__endTimestamp 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | ------- Summary: start ------- 03:24:57 INFO - PROCESS | 4145 | Number of tests: 6 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#0] dojo.html Cycles:165 Average:5279.89 Median:5451.65 stddev:587.46 (10.8%) stddev-sans-first:560.96 03:24:57 INFO - PROCESS | 4145 | Values: 2983.5 3010.1 3022.9 3053.7 3077.0 5118.0 5200.4 5257.2 5266.2 5303.9 5280.7 5289.8 5336.1 5338.2 5364.1 4799.9 4818.6 4836.7 4849.9 4931.9 4937.4 4956.5 4973.4 4973.6 4975.7 4765.4 4802.7 4813.5 4911.1 4922.9 4851.1 4860.0 4861.9 4862.1 4862.9 4816.3 4833.0 4833.9 4839.0 4840.8 5263.4 5308.9 5312.6 5315.9 5319.6 5649.8 5652.3 5653.2 5654.5 5663.0 5638.4 5649.4 5672.2 5676.7 5677.6 5180.4 5198.3 5225.1 5232.5 5235.3 5821.9 5828.6 5833.2 5834.8 5835.5 5435.7 5480.7 5525.3 5551.0 5611.9 5625.3 5638.8 5643.9 5655.2 5704.7 5663.1 5675.2 5676.5 5677.5 5680.6 5586.2 5597.1 5634.6 5643.7 5653.9 4430.0 4430.4 4477.8 4478.5 4482.0 3918.5 3941.0 3951.4 3961.4 4000.6 5287.5 5322.0 5365.3 5422.2 5496.2 5673.9 5702.9 5704.7 5739.9 5767.5 5409.6 5412.4 5432.3 5442.6 5443.1 4763.2 4857.0 4941.5 4945.5 4994.3 5800.1 5815.0 5824.9 5828.1 5880.7 5764.1 5774.8 5778.9 5782.2 5791.1 5881.7 5911.9 5916.0 5919.3 5937.3 5549.3 5590.2 5615.3 5626.4 5634.9 5564.3 5622.1 5641.7 5688.5 5695.4 5526.9 5581.1 5583.7 5588.5 5632.8 5468.6 5500.9 5513.9 5518.1 5525.6 5396.4 5447.7 5451.6 5511.0 5570.9 5571.7 5583.5 5584.4 5631.6 5647.7 5356.8 5359.4 5406.1 5423.2 5444.5 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#1] ext.html Cycles:180 Average:58535.41 Median:41267.50 stddev:114883.79 (278.4%) stddev-sans-first:115123.61 03:24:57 INFO - PROCESS | 4145 | Values: 560.9 583.8 593.4 607.5 608.6 43734.1 45095.5 45205.3 45209.0 48410.3 46504.8 46886.0 46904.7 46987.3 47076.3 9027.9 9149.5 9182.6 9185.9 9186.3 8897.6 8936.3 9003.7 9025.4 9030.8 8938.2 9020.5 9025.5 9065.1 9066.5 8897.4 8961.2 8965.9 8993.8 9002.8 8932.0 9010.9 9046.4 9068.1 9073.6 42072.6 42295.0 42412.6 42426.6 42528.1 3188.7 3189.1 3234.4 3502.5 3554.4 31735.2 32151.4 32174.4 32181.0 32914.0 4296.9 4328.8 4337.8 4345.3 4422.3 337269.0 337282.0 338974.0 339409.0 339466.3 58939.1 59183.4 59279.4 59347.7 59394.0 36357.8 37156.3 37358.6 62536.7 62548.7 14417.8 14524.2 14570.6 14571.6 14576.6 10679.8 10749.2 10773.7 10773.7 10780.9 19254.9 19450.9 19460.9 19463.7 19476.4 7224.0 7333.8 7337.7 7354.9 7541.7 928.3 960.6 982.0 983.2 1063.4 31497.5 31718.7 31766.8 31846.5 31950.4 1085.1 1126.2 1126.8 1135.8 1176.2 15864.1 16785.9 16940.9 17022.1 17271.6 533606.0 539932.0 540691.0 540864.0 541695.0 57347.0 57523.0 58203.7 58259.1 58262.0 1195.2 1241.3 1291.8 1318.7 1328.1 28716.4 32346.7 32488.8 32834.1 32999.3 50290.5 50909.2 50935.2 50943.5 50962.5 396988.0 397246.0 397393.0 397479.0 397943.0 27649.6 28498.1 28622.6 28784.9 29686.3 46208.5 46684.8 46831.3 47202.0 47455.5 39612.8 39892.4 40078.6 41053.0 41782.0 39122.6 39411.1 40661.8 40847.2 41689.0 39499.6 39654.0 39897.2 40279.4 41482.0 33011.7 36133.6 36661.5 36676.0 36901.4 27888.3 28196.9 28213.0 28263.3 28604.4 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#2] jquery.html Cycles:180 Average:27096.67 Median:211636.24 stddev:74343.96 (35.1%) stddev-sans-first:74525.43 03:24:57 INFO - PROCESS | 4145 | Values: 372.7 392.5 394.7 403.1 423.5 13392.5 15668.0 17394.7 19644.0 20247.4 18391.6 18738.4 19040.7 19094.8 19290.0 5553.6 5601.5 5824.6 5826.9 5828.8 5640.5 5705.0 5726.9 5737.7 5743.3 5538.6 5698.3 5708.4 5708.7 5711.3 5776.2 5924.3 5941.7 5943.9 5945.3 5615.8 5736.5 5769.5 5770.9 5778.7 14206.1 14307.6 14416.6 14425.1 14432.6 2077.3 2113.8 2153.7 2384.2 2939.8 9112.1 9299.7 9666.0 9987.1 14327.2 1749.9 1815.1 1867.9 1888.3 1918.9 79993.0 80029.6 80954.0 84117.6 84643.6 10880.3 11046.5 11054.6 11168.3 11220.4 15370.5 15394.8 15507.6 15515.1 15571.3 7229.7 7322.3 7347.8 7457.7 7467.4 6586.1 6657.5 6826.0 6988.4 7161.3 4707.7 4756.5 4845.2 4848.3 4947.7 1901.8 1950.2 1951.3 1986.5 2027.8 853.7 920.8 923.8 1047.5 1071.3 17533.8 19114.7 19118.3 19227.0 19233.7 948.8 953.2 953.7 967.9 973.3 9839.0 10821.2 10837.1 10862.7 10875.5 422849.0 441974.0 459173.0 460542.0 461274.0 87804.0 88193.6 88419.7 91352.0 91532.8 980.4 997.8 1016.7 1019.8 1024.0 16310.9 16769.5 17221.0 17227.6 17256.5 29174.4 32854.5 37116.1 41422.6 42550.0 54923.5 55149.0 55373.4 55791.0 56256.0 8237.9 8311.7 8446.2 8515.1 8580.6 10595.6 12788.0 12832.6 13006.8 13219.3 10554.9 10775.8 11053.0 11171.1 11536.8 10616.8 10795.5 11256.8 11287.7 11456.1 6163.2 8481.2 10358.9 10938.2 11328.4 8224.1 8334.5 8386.2 8442.1 8684.4 9825.0 10449.6 10658.3 10962.7 11330.4 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#3] mootools.html Cycles:180 Average:5829.18 Median:4616.76 stddev:3344.66 (72.4%) stddev-sans-first:3336.85 03:24:57 INFO - PROCESS | 4145 | Values: 1316.4 1413.9 1445.3 1543.3 1723.9 7652.4 8699.3 9009.1 9018.4 9130.0 8938.8 8986.4 9008.1 9012.6 9014.7 2370.3 2394.1 2402.1 2406.3 2406.6 2343.4 2399.1 2418.8 2419.4 2419.5 2323.5 2348.3 2350.6 2357.0 2362.8 2333.9 2353.6 2363.3 2364.0 2389.3 2294.4 2327.4 2349.7 2350.7 2359.3 7878.6 8140.7 8993.0 9131.6 9184.3 5226.8 5382.5 5384.6 5481.5 5487.2 3447.3 3503.5 3511.5 3526.5 3563.5 1121.6 1126.1 1136.9 1151.2 1157.8 12567.7 12655.9 12727.2 12783.3 12785.5 4543.2 4690.3 4827.8 4885.2 4893.6 10163.6 10163.6 10178.3 10180.6 10185.9 5336.2 5380.8 5398.6 5409.5 5429.1 4829.3 4932.4 4953.7 4972.5 4979.7 3807.4 3832.0 3901.5 3905.2 3954.2 1146.9 1148.7 1168.4 1186.6 1188.9 827.6 932.5 935.8 958.9 979.6 5945.1 5984.3 6057.4 6264.9 6372.3 440.7 449.0 450.5 450.6 452.8 3858.0 4179.8 4187.5 4271.7 4275.4 10092.9 10407.9 10840.5 11226.4 11280.9 11216.8 11236.4 11246.2 11261.5 11304.3 7203.6 7456.7 7457.3 8335.5 8475.9 5628.0 5809.4 5880.8 5962.9 6246.3 10127.0 10201.6 10266.5 10367.0 10383.2 10381.7 10447.7 10547.6 10562.4 10663.9 7179.9 7227.0 7236.1 7274.1 7275.0 8244.3 8257.6 8287.0 8331.0 8341.2 7325.2 7591.4 7673.1 7721.0 7967.2 7600.3 7603.3 7661.5 7704.7 7829.3 7285.9 7306.5 7365.3 7367.1 7371.0 5205.7 5257.2 5400.5 5407.1 5415.4 5349.7 5376.1 5387.1 5401.8 5482.8 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#4] prototype.html Cycles:180 Average:4556.67 Median:5119.26 stddev:1318.07 (25.7%) stddev-sans-first:1282.86 03:24:57 INFO - PROCESS | 4145 | Values: 321.4 331.8 334.9 340.4 341.3 5028.6 5124.6 5148.3 5235.4 5261.9 4973.4 5110.6 5132.0 5146.6 5173.9 4057.7 4115.9 4120.4 4132.9 4134.5 3890.5 4091.5 4110.7 4131.9 4138.4 4091.0 4097.2 4099.7 4100.2 4104.5 4085.4 4087.0 4092.9 4104.8 4125.2 3574.5 3679.5 3689.4 3700.3 3710.8 5088.8 5114.9 5117.2 5121.4 5135.8 4722.6 4727.5 4730.6 4749.3 4749.7 5129.2 5313.7 5394.6 5474.2 5484.4 3962.4 3965.9 3975.8 3985.8 4015.2 5639.9 5649.1 5650.1 5660.8 5664.0 3856.6 4044.3 4093.8 4109.6 4128.6 4102.9 4103.8 4105.5 4122.8 4159.4 4646.6 4660.7 4689.8 4696.2 4697.5 5197.9 5457.5 5467.2 5489.9 5498.8 1418.2 1438.4 1440.6 1441.0 1444.1 913.7 935.5 946.6 947.0 956.7 4672.3 4711.3 4719.5 4730.2 4767.7 4911.3 4924.4 4939.5 4955.3 4986.2 4712.2 4738.8 4751.5 4798.7 4956.2 2890.9 2959.5 2960.2 2964.8 2975.0 5749.0 5751.8 5760.5 5761.3 5770.7 5593.6 5696.6 5719.7 5741.7 5749.0 5755.4 5777.6 5781.9 5793.0 5793.3 5392.6 5500.0 5568.8 5574.2 5587.6 5535.1 5552.7 5563.7 5568.3 5568.7 5696.4 5744.2 5759.6 5799.1 5807.2 3777.5 3871.3 3911.5 3936.3 3939.6 5515.9 5544.9 5547.7 5548.5 5558.5 5430.4 5434.3 5450.5 5454.4 5461.8 5191.7 5408.8 5417.4 5423.7 5430.7 5376.3 5386.4 5396.8 5414.4 5415.9 5217.8 5401.9 5413.6 5421.5 5460.2 5343.5 5371.5 5386.1 5396.6 5399.3 03:24:57 INFO - PROCESS | 4145 | 03:24:57 INFO - PROCESS | 4145 | [#5] yui.html Cycles:180 Average:20786.90 Median:49981.51 stddev:31098.61 (62.2%) stddev-sans-first:31149.31 03:24:57 INFO - PROCESS | 4145 | Values: 707.7 710.6 771.1 774.3 826.8 15091.9 15499.8 15529.5 15672.3 15698.9 14953.3 15151.2 15156.0 15159.7 15167.6 774.7 795.5 798.8 799.3 799.5 788.3 789.9 790.5 791.7 792.0 836.1 844.0 844.3 849.6 850.4 845.6 845.7 846.2 846.2 846.2 623.9 624.0 624.5 624.8 624.8 14276.5 14279.6 14285.4 14304.4 14309.8 12304.7 12566.4 12733.3 12793.2 13197.7 11080.2 11260.5 11286.9 11566.2 11593.4 3424.4 3487.6 3503.9 3526.7 3552.1 78898.0 80048.6 80253.6 81052.6 81563.0 8597.6 8718.3 8768.1 9364.8 9502.5 20144.4 20424.3 20515.6 20632.6 20634.0 7895.3 8207.3 8276.5 8405.0 8834.0 4700.7 4752.5 4847.8 4865.5 4917.3 3509.6 3588.7 3640.3 3643.3 3643.9 586.1 600.9 609.2 611.3 630.6 653.7 666.5 682.7 686.1 691.2 8752.5 9066.6 9379.7 9383.2 9672.8 552.3 577.2 612.0 644.8 653.7 3828.9 4116.6 4162.5 4441.1 4446.5 86715.6 126223.4 127304.4 128346.0 128942.0 69920.0 105451.0 106235.5 108057.5 109483.0 84790.2 92176.5 93221.5 96454.0 96658.5 8730.8 8827.1 8876.6 9062.5 9387.8 49814.5 50148.5 50478.5 52255.8 52652.5 64210.4 64756.0 66724.7 75456.2 76924.0 11657.1 11882.9 11959.2 11980.6 12235.2 13843.7 14453.9 14887.2 14907.5 15025.2 12265.8 12533.7 12623.9 12816.3 13078.8 13726.0 14326.9 14402.9 14588.6 15018.4 11841.7 12079.9 13118.3 13730.9 14185.6 9829.6 9972.4 10259.9 10345.6 10633.9 9696.7 10002.2 10509.5 11513.7 12168.5 03:24:57 INFO - PROCESS | 4145 | -------- Summary: end -------- 03:24:57 INFO - PROCESS | 4145 | 03:24:58 INFO - TEST-INFO | 4145: exit 0 03:24:58 INFO - TEST-OK | dromaeo_css | took 1116172ms 03:24:58 INFO - TEST-START | kraken 03:24:58 INFO - operating with platform_type : linux_ 03:24:58 INFO - Initialising browser for kraken test... 03:24:58 INFO - TEST-INFO | started process 4454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx68ZNR/profile http://localhost:43512/getInfo.html) 03:25:02 INFO - PROCESS | 4454 | __metrics Screen width/height:1600/1200 03:25:02 INFO - PROCESS | 4454 | colorDepth:24 03:25:02 INFO - PROCESS | 4454 | Browser inner width/height: 1024/697 03:25:02 INFO - PROCESS | 4454 | __metrics 03:25:03 INFO - PROCESS | 4454 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:25:03 INFO - PROCESS | 4454 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:03 INFO - PROCESS | 4454 | console.error: PushService: 03:25:03 INFO - PROCESS | 4454 | stateChangeProcessEnqueue: Error transitioning state 03:25:03 INFO - PROCESS | 4454 | UnknownError 03:25:04 INFO - TEST-INFO | 4454: exit 0 03:25:04 INFO - Browser initialized. 03:25:04 INFO - Running cycle 1/1 for kraken test... 03:25:04 INFO - TEST-INFO | started process 4538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx68ZNR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:16 INFO - PROCESS | 4538 | RSS: Main: 173613056 03:25:16 INFO - PROCESS | 4538 | 03:25:19 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43512/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:20 INFO - PROCESS | 4538 | RSS: Main: 233832448 03:25:20 INFO - PROCESS | 4538 | 03:25:22 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43512/tests/kraken/driver.html?testName=audio-dft) 03:25:23 INFO - PROCESS | 4538 | RSS: Main: 218353664 03:25:23 INFO - PROCESS | 4538 | 03:25:26 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43512/tests/kraken/driver.html?testName=audio-fft) 03:25:27 INFO - PROCESS | 4538 | RSS: Main: 298848256 03:25:27 INFO - PROCESS | 4538 | 03:25:29 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43512/tests/kraken/driver.html?testName=audio-oscillator) 03:25:29 INFO - PROCESS | 4538 | RSS: Main: 208318464 03:25:29 INFO - PROCESS | 4538 | 03:25:32 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:25:32 INFO - PROCESS | 4538 | RSS: Main: 212520960 03:25:32 INFO - PROCESS | 4538 | 03:25:35 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43512/tests/kraken/driver.html?testName=imaging-darkroom) 03:25:36 INFO - PROCESS | 4538 | RSS: Main: 249307136 03:25:36 INFO - PROCESS | 4538 | 03:25:39 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43512/tests/kraken/driver.html?testName=imaging-desaturate) 03:25:40 INFO - PROCESS | 4538 | RSS: Main: 248369152 03:25:40 INFO - PROCESS | 4538 | 03:25:42 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43512/tests/kraken/driver.html?testName=json-parse-financial) 03:25:43 INFO - PROCESS | 4538 | RSS: Main: 248020992 03:25:43 INFO - PROCESS | 4538 | 03:25:45 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:25:45 INFO - PROCESS | 4538 | RSS: Main: 210530304 03:25:45 INFO - PROCESS | 4538 | 03:25:47 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:25:48 INFO - PROCESS | 4538 | RSS: Main: 217006080 03:25:48 INFO - PROCESS | 4538 | 03:25:50 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:25:50 INFO - PROCESS | 4538 | RSS: Main: 222498816 03:25:50 INFO - PROCESS | 4538 | 03:25:53 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:25:53 INFO - PROCESS | 4538 | RSS: Main: 223387648 03:25:53 INFO - PROCESS | 4538 | 03:25:56 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:25:57 INFO - PROCESS | 4538 | RSS: Main: 221474816 03:25:57 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | Cycle 1(1): loaded http://localhost:43512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43512/tests/kraken/driver.html?testName=ai-astar) 03:25:59 INFO - PROCESS | 4538 | RSS: Main: 272814080 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | __start_tp_report 03:25:59 INFO - PROCESS | 4538 | _x_x_mozilla_page_load 03:25:59 INFO - PROCESS | 4538 | _x_x_mozilla_page_load_details 03:25:59 INFO - PROCESS | 4538 | |i|pagename|runs| 03:25:59 INFO - PROCESS | 4538 | |0;ai-astar;110;110;110;109;111;111;111;112;110;110 03:25:59 INFO - PROCESS | 4538 | |1;audio-beat-detection;151;122;123;159;121;120;119;118;154;123 03:25:59 INFO - PROCESS | 4538 | |2;audio-dft;165;162;161;162;163;163;162;162;161;161 03:25:59 INFO - PROCESS | 4538 | |3;audio-fft;75;76;76;106;77;75;77;76;103;76 03:25:59 INFO - PROCESS | 4538 | |4;audio-oscillator;83;84;120;84;84;83;106;83;83;118 03:25:59 INFO - PROCESS | 4538 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;118;117;118 03:25:59 INFO - PROCESS | 4538 | |6;imaging-darkroom;146;146;145;146;145;147;146;147;146;148 03:25:59 INFO - PROCESS | 4538 | |7;imaging-desaturate;94;95;96;95;95;96;95;95;95;96 03:25:59 INFO - PROCESS | 4538 | |8;json-parse-financial;53;52;51;51;52;54;53;52;54;52 03:25:59 INFO - PROCESS | 4538 | |9;json-stringify-tinderbox;61;62;60;61;63;61;61;61;61;64 03:25:59 INFO - PROCESS | 4538 | |10;stanford-crypto-aes;86;79;78;78;78;80;79;87;78;77 03:25:59 INFO - PROCESS | 4538 | |11;stanford-crypto-ccm;135;130;125;131;131;134;122;121;166;134 03:25:59 INFO - PROCESS | 4538 | |12;stanford-crypto-pbkdf2;168;166;166;168;163;165;165;164;164;170 03:25:59 INFO - PROCESS | 4538 | |13;stanford-crypto-sha256-iterative;66;68;66;65;65;66;68;65;69;69 03:25:59 INFO - PROCESS | 4538 | __end_tp_report 03:25:59 INFO - PROCESS | 4538 | __start_cc_report 03:25:59 INFO - PROCESS | 4538 | _x_x_mozilla_cycle_collect,1661 03:25:59 INFO - PROCESS | 4538 | __end_cc_report 03:25:59 INFO - PROCESS | 4538 | __startTimestamp1474971959280__endTimestamp 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | ------- Summary: start ------- 03:25:59 INFO - PROCESS | 4538 | Number of tests: 14 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 03:25:59 INFO - PROCESS | 4538 | Values: 110.0 110.0 110.0 109.0 111.0 111.0 111.0 112.0 110.0 110.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:123.00 stddev:16.52 (13.4%) stddev-sans-first:15.86 03:25:59 INFO - PROCESS | 4538 | Values: 151.0 122.0 123.0 159.0 121.0 120.0 119.0 118.0 154.0 123.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:0.78 03:25:59 INFO - PROCESS | 4538 | Values: 165.0 162.0 161.0 162.0 163.0 163.0 162.0 162.0 161.0 161.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.06 (15.9%) stddev-sans-first:12.54 03:25:59 INFO - PROCESS | 4538 | Values: 75.0 76.0 76.0 106.0 77.0 75.0 77.0 76.0 103.0 76.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.00 stddev:15.51 (18.7%) stddev-sans-first:16.04 03:25:59 INFO - PROCESS | 4538 | Values: 83.0 84.0 120.0 84.0 84.0 83.0 106.0 83.0 83.0 118.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:25:59 INFO - PROCESS | 4538 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:25:59 INFO - PROCESS | 4538 | Values: 146.0 146.0 145.0 146.0 145.0 147.0 146.0 147.0 146.0 148.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 03:25:59 INFO - PROCESS | 4538 | Values: 94.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.07 (2.0%) stddev-sans-first:1.12 03:25:59 INFO - PROCESS | 4538 | Values: 53.0 52.0 51.0 51.0 52.0 54.0 53.0 52.0 54.0 52.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.18 (1.9%) stddev-sans-first:1.24 03:25:59 INFO - PROCESS | 4538 | Values: 61.0 62.0 60.0 61.0 63.0 61.0 61.0 61.0 61.0 64.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.53 (4.5%) stddev-sans-first:3.00 03:25:59 INFO - PROCESS | 4538 | Values: 86.0 79.0 78.0 78.0 78.0 80.0 79.0 87.0 78.0 77.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:132.50 stddev:12.65 (9.5%) stddev-sans-first:13.40 03:25:59 INFO - PROCESS | 4538 | Values: 135.0 130.0 125.0 131.0 131.0 134.0 122.0 121.0 166.0 134.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:2.18 (1.3%) stddev-sans-first:2.18 03:25:59 INFO - PROCESS | 4538 | Values: 168.0 166.0 166.0 168.0 163.0 165.0 165.0 164.0 164.0 170.0 03:25:59 INFO - PROCESS | 4538 | 03:25:59 INFO - PROCESS | 4538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.64 (2.4%) stddev-sans-first:1.72 03:25:59 INFO - PROCESS | 4538 | Values: 66.0 68.0 66.0 65.0 65.0 66.0 68.0 65.0 69.0 69.0 03:25:59 INFO - PROCESS | 4538 | -------- Summary: end -------- 03:25:59 INFO - PROCESS | 4538 | 03:26:00 INFO - TEST-INFO | 4538: exit 0 03:26:00 INFO - TEST-OK | kraken | took 61882ms 03:26:00 INFO - SUITE-END | took 1178s 03:26:00 INFO - Completed test suite (00:19:38) 03:26:00 INFO - javascript benchmark 03:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.492806222942, 3010.1270631516863, 3022.8639711212995, 3053.694630536948, 3076.953845692315, 5117.974410127954, 5200.427952925175, 5257.185136303874, 5266.236395722623, 5303.920441193381, 5280.683159010462, 5289.788408463666, 5336.146216605344, 5338.172583249602, 5364.061289274371, 4799.928001079987, 4818.566329030386, 4836.733979631119, 4849.903001939959, 4931.926021109668, 4937.432195297551, 4956.5043495650325, 4973.353464049668, 4973.5772459340815, 4975.676581022222, 4765.380500534909, 4802.735849528274, 4813.542713442217, 4911.091448082098, 4922.876928076791, 4851.126797176506, 4859.975700121477, 4861.854144375674, 4862.124817532878, 4862.878428039292, 4816.349792777965, 4832.975835120802, 4833.936533962523, 4839.0, 4840.757962101916, 5263.368395792491, 5308.92036619451, 5312.6281160318795, 5315.867103322409, 5319.627626066177, 5649.774009039634, 5652.349979752299, 5653.236813030229, 5654.46282603152, 5662.971685141589, 5638.436156384329, 5649.378568357477, 5672.205891175238, 5676.687782171979, 5677.57418193633, 5180.4042535108565, 5198.298229738974, 5225.085610018232, 5232.450592687789, 5235.319408476912, 5821.883562328814, 5828.604785768423, 5833.241678581842, 5834.766609335664, 5835.533157347402, 5435.701036443033, 5480.725963701799, 5525.281713377235, 5550.972245138749, 5611.859703507445, 5625.268715067015, 5638.802641907513, 5643.887122257614, 5655.1799989001365, 5704.686242256716, 5663.065594176997, 5675.233843431167, 5676.517496012802, 5677.460641239076, 5680.602357834912, 5586.16207568868, 5597.104463285855, 5634.577406694514, 5643.689597072201, 5653.858653533613, 4429.955700443019, 4430.424044874146, 4477.820887164542, 4478.529754375809, 4482.036362182146, 3918.490596222473, 3941.0344465605535, 3951.4270430787374, 3961.425593288957, 4000.6199411055904, 5287.4976877196605, 5322.0, 5365.275687782178, 5422.15956526739, 5496.1755736639825, 5673.858153546194, 5702.857428564236, 5704.71476426177, 5739.942600574024, 5767.480926716532, 5409.6483728558305, 5412.404635490093, 5432.348118225838, 5442.564594832404, 5443.129099344086, 4763.214069678534, 4856.975715121402, 4941.45643979162, 4945.455999840015, 4994.300797888299, 5800.100984347433, 5815.040518314515, 5824.883502330014, 5828.125781132864, 5880.705964701662, 5764.106563482667, 5774.769009239583, 5778.913316300175, 5782.1615865698395, 5791.102379131242, 5881.738767271089, 5911.852203694942, 5915.970420147872, 5919.348871624204, 5937.287525496968, 5549.250851135045, 5590.189422533791, 5615.298087739033, 5626.409227031103, 5634.887302254014, 5564.276644036249, 5622.072358060874, 5641.661500309994, 5688.54491640676, 5695.430456954271, 5526.944730552643, 5581.13492408661, 5583.720813959367, 5588.497035266845, 5632.802851900164, 5468.644538105011, 5500.9273191727225, 5513.944860551504, 5518.117101263779, 5525.613207075467, 5396.433374495621, 5447.727613619224, 5451.64564303319, 5511.035568775368, 5570.888582228252, 5571.721413929206, 5583.497485226349, 5584.385717570983, 5631.577631677723, 5647.717614119196, 5356.839294821161, 5359.410464848941, 5406.0809662356705, 5423.186522021729, 5444.50999410055], "value": 5240.53238770471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9248419345064, 583.8073435766196, 593.4214141212321, 607.5048835199309, 608.5922431970579, 43734.12531749367, 45095.54904450954, 45205.32192017118, 45209.0, 48410.27384589234, 46504.767476162655, 46886.0, 46904.66786983765, 46987.295190572084, 47076.29385559211, 9027.909720902806, 9149.451032938045, 9182.632694692204, 9185.908140918606, 9186.265098792113, 8897.599608017656, 8936.32977526688, 9003.684871029514, 9025.368224224307, 9030.774230644221, 8938.240249578794, 9020.45877247364, 9025.458472491639, 9065.093490650916, 9066.501342426163, 8897.421667591585, 8961.193492585666, 8965.910340896573, 8993.77515562113, 9002.819943601156, 8931.955340223258, 9010.86483702745, 9046.3667543272, 9068.138526839939, 9073.63705451781, 42072.57927420748, 42295.0, 42412.57587424117, 42426.57573424257, 42528.149437011394, 3188.7449004079617, 3189.1070500259966, 3234.4151365830808, 3502.492138639883, 3554.413521768905, 31735.206619834687, 32151.356972860412, 32174.356512869846, 32181.0, 32914.0, 4296.871093867189, 4328.761918094535, 4337.783110844477, 4345.348197770328, 4422.270325396305, 337269.0, 337282.0, 338974.0, 339409.0, 339466.30266848754, 58939.11591326133, 59183.40816591865, 59279.40720592739, 59347.70326148342, 59394.0, 36357.81821090878, 37156.25687486235, 37358.626413736056, 62536.687316563126, 62548.687256563426, 14417.78373324401, 14524.201168935599, 14570.63573410652, 14571.562853114423, 14576.562703118923, 10679.786404272027, 10749.193810464247, 10773.676789696321, 10773.730656733644, 10780.94609526963, 19254.903725481563, 19450.902745486183, 19460.90269548643, 19463.708044379346, 19476.4157075288, 7224.030837444293, 7333.779986600411, 7337.669804858688, 7354.889676654854, 7541.660625271876, 928.2991341537096, 960.6205548808322, 981.9803603928025, 983.1839573154265, 1063.4257500949554, 31497.52753708696, 31718.682813172036, 31766.841165794023, 31846.522302165486, 31950.367975243462, 1085.1427372375892, 1126.2397881430002, 1126.7690123524658, 1135.7728454309172, 1176.2295696318924, 15864.098848067468, 16785.91607041957, 16940.91529542369, 17022.148892555324, 17271.56821079483, 533606.0, 539932.0, 540691.0, 540864.0, 541695.0, 57347.0, 57523.0, 58203.70898145567, 58259.12611310834, 58262.0, 1195.1633856300625, 1241.30486927321, 1291.799771035491, 1318.7032917593465, 1328.1367111377488, 28716.42567148687, 32346.676533234368, 32488.837555813014, 32834.13928909774, 32999.34001320008, 50290.49709503005, 50909.23636145535, 50935.235971461196, 50943.49056509536, 50962.490375095775, 396988.0, 397246.0, 397393.0, 397479.0, 397943.0, 27649.585256221577, 28498.14762040461, 28622.570661439677, 28784.856075719486, 29686.257843554085, 46208.53791462042, 46684.76657616826, 46831.29753053639, 47202.0, 47455.52544474511, 39612.80193599014, 39892.40161397639, 40078.58154330964, 41053.0, 41782.0, 39122.608773911896, 39411.1177764454, 40661.79669101635, 40847.1830563393, 41689.0, 39499.60500395074, 39654.0, 39897.2020559593, 40279.3958090623, 41482.0, 33011.66988330086, 36133.63866361408, 36661.45007824938, 36676.0, 36901.44647830231, 27888.302792430353, 28196.85901570479, 28213.0, 28263.2934176639, 28604.42791144207], "value": 19740.926084131388, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.74466990111756, 392.5074032089729, 394.73552719677804, 403.0829862063805, 423.48123548652904, 13392.464301427943, 15667.981581197228, 17394.652106957852, 19644.0, 20247.392578222676, 18391.632167356678, 18738.43784686458, 19040.71438928417, 19094.809051909477, 19290.0, 5553.583481238903, 5601.523870471015, 5824.621399609033, 5826.941730582682, 5828.795992140276, 5640.520555752745, 5705.0, 5726.942730572703, 5737.684427356494, 5743.282089738783, 5538.6122971392015, 5698.344690360599, 5708.372079071299, 5708.714564271791, 5711.2575365202465, 5776.249087618604, 5924.259467566554, 5941.673207973559, 5943.851403714899, 5945.256842894638, 5615.831525054255, 5736.541076713853, 5769.538436925036, 5770.9422905770825, 5778.711064446761, 14206.147631142165, 14307.57077287683, 14416.63958401038, 14425.134491930517, 14432.639184020378, 2077.3248694174454, 2113.841461890349, 2153.6554151335868, 2384.248961577098, 2939.8236105833503, 9112.088791120901, 9299.6898115008, 9665.951670241675, 9987.051230133126, 14327.212003339811, 1749.8775085744003, 1815.0833828916445, 1867.8785878917827, 1888.2730148892638, 1918.932837350686, 79993.00069993013, 80029.59985200095, 80954.0, 84117.57941210316, 84643.57678211569, 10880.347179169275, 11046.502907369188, 11054.557817687202, 11168.329900206014, 11220.382878941737, 15370.538883833502, 15394.846051539565, 15507.612309692347, 15515.146666933428, 15571.299291531908, 7229.664717637397, 7322.267773222635, 7347.7795666130105, 7457.7016919323705, 7467.439942004371, 6586.1438013058, 6657.533972621967, 6826.044353790473, 6988.44092472601, 7161.283871612901, 4707.693999889996, 4756.500567440438, 4845.152098382769, 4848.272759086095, 4947.65366424354, 1901.8288354048202, 1950.2199120351688, 1951.2877799603043, 1986.4934441717269, 2027.8174964253287, 853.6585365853584, 920.8250432417819, 923.8475651517424, 1047.5495536919198, 1071.287593750163, 17533.77263591562, 19114.71327930082, 19118.33085841989, 19227.0, 19233.711494327596, 948.7960088580988, 953.2231231546267, 953.7472569769017, 967.8983706710694, 973.2651847854825, 9838.950805246071, 10821.188410869216, 10837.078848297982, 10862.72843178911, 10875.510602022929, 422849.0, 441974.0, 459173.0, 460542.0, 461274.0, 87804.0, 88193.55903220571, 88419.71592982773, 91352.0, 91532.81241407593, 980.367662857453, 997.8054279415444, 1016.7102375822855, 1019.8368261078192, 1024.032289486443, 16310.918445407697, 16769.496915092568, 17221.0, 17227.569310767332, 17256.482305530855, 29174.41651167007, 32854.507182391804, 37116.072098197765, 41422.58577414187, 42550.0, 54923.450765493435, 55149.0, 55373.44626553844, 55791.0, 56256.0, 8237.917620823955, 8311.6675332986, 8446.155384461505, 8515.105913878953, 8580.59978006087, 10595.576176952836, 12788.0, 12832.55086071983, 13006.80489792635, 13219.339033048116, 10554.894451055392, 10775.838362424412, 11053.0, 11171.106311494897, 11536.826947595624, 10616.84074738895, 10795.460226988462, 11256.831147532957, 11287.717807054889, 11456.083513318748, 6163.19878415803, 8481.194286542768, 10358.896411036094, 10938.234323597271, 11328.376939268419, 8224.095349511668, 8334.541600212047, 8386.161383861809, 8442.113578074459, 8684.435511691972, 9825.0, 10449.58201671955, 10658.307210031324, 10962.671119866416, 11330.433478326215], "value": 8799.977384350444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.3615646411483, 1413.8515455877132, 1445.3495926832925, 1543.3055125193666, 1723.8879472834265, 7652.426068044898, 8699.304055675546, 9009.099090090987, 9018.36871419, 9129.95435022824, 8938.776530586721, 8986.37095403322, 9008.09919008099, 9012.639494420215, 9014.729558113268, 2370.3481542575755, 2394.1022116706235, 2402.0872068613903, 2406.266088842911, 2406.5908795504806, 2343.4024323797407, 2399.1363109280646, 2418.842775219614, 2419.3830573203895, 2419.5160967806423, 2323.546908352872, 2348.2602980061224, 2350.6239001759723, 2357.0, 2362.83460157789, 2333.9183128590416, 2353.5881220786378, 2363.3146387547677, 2363.95272094558, 2389.2712722619594, 2294.3919861236786, 2327.44141406063, 2349.741528431888, 2350.717913850332, 2359.315798418457, 7878.606069696492, 8140.674373025072, 8993.010768815426, 9131.589078491485, 9184.265258779282, 5226.843194704165, 5382.515573598355, 5384.596155288369, 5481.5340696040885, 5487.204355368449, 3447.276072024878, 3503.544539209912, 3511.543499345069, 3526.488659144435, 3563.465480177994, 1121.601831349867, 1126.0653657464286, 1136.8692600350983, 1151.205668089016, 1157.8321143434239, 12567.748645027048, 12655.873441265561, 12727.23636581808, 12783.29691866947, 12785.488580456771, 4543.204939135704, 4690.319903613957, 4827.789519969181, 4885.218365061573, 4893.559579637849, 10163.593456261668, 10163.644272450429, 10178.287519873686, 10180.643677471253, 10185.898141018642, 5336.226247194213, 5380.78476860929, 5398.64908780928, 5409.459054094637, 5429.131338985743, 4829.27560865873, 4932.408111026628, 4953.7275449849885, 4972.477889821589, 4979.701217926936, 3807.428885667172, 3831.980840095782, 3901.49280593521, 3905.207776439859, 3954.209158168378, 1146.873843877173, 1148.7472755993667, 1168.3690806964314, 1186.6202815099086, 1188.8751681073363, 827.6317038917624, 932.5011119051275, 935.8034812689411, 958.8513780364054, 979.647326962293, 5945.137954996588, 5984.3417224105315, 6057.363976782374, 6264.874702506016, 6372.330905254974, 440.66729619137345, 449.03681602961467, 450.5314472948097, 450.63498566161513, 452.8256621200861, 3857.9614203858164, 4179.791010449465, 4187.497500299984, 4271.722338048017, 4275.3800698898485, 10092.949535252423, 10407.895921040692, 10840.457977101114, 11226.438678066064, 11280.887191128148, 11216.775664486664, 11236.381998990135, 11246.212765106528, 11261.549538018551, 11304.265222760494, 7203.567785932861, 7456.664450099867, 7457.291557302047, 8335.54154521495, 8475.915240847637, 5627.971860140837, 5809.448102430262, 5880.8235752927485, 5962.9105563415715, 6246.344133865879, 10127.0, 10201.642942496977, 10266.486675666336, 10367.0, 10383.2212584055, 10381.732787049246, 10447.68656940293, 10547.630832920811, 10562.419066951392, 10663.946680266548, 7179.8564028720175, 7227.0, 7236.131664200329, 7274.054372931485, 7274.96362518184, 8244.29923456513, 8257.628406721591, 8287.046989596274, 8330.958345208235, 8341.16588341161, 7325.157606875277, 7591.430642701709, 7673.117591477052, 7721.0, 7967.163447837894, 7600.2779735925, 7603.279455614368, 7661.502002369828, 7704.6918123274445, 7829.334506566778, 7285.854282914206, 7306.488545801955, 7365.300296471826, 7367.115946086504, 7370.96314518424, 5205.6616319939085, 5257.158854583248, 5400.513953744182, 5407.134858422633, 5415.4313797050745, 5349.732513374238, 5376.1398176291605, 5387.111126664056, 5401.756920938488, 5482.753276102505], "value": 4570.70531894034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.437484402296, 331.79262960649595, 334.90790032741006, 340.38390513171146, 341.2696828786397, 5028.572571331432, 5124.641275110744, 5148.304978827857, 5235.361423810453, 5261.921071183935, 4973.428055773587, 5110.565601923841, 5132.024170694282, 5146.5625421839095, 5173.870653233671, 4057.7159598828093, 4115.938260926088, 4120.381942708587, 4132.938005929914, 4134.4856871659, 3890.455336252927, 4091.5499295077516, 4110.671146308303, 4131.938020929689, 4138.3999320098565, 4091.0, 4097.160082183145, 4099.692523060782, 4100.241455330758, 4104.466419365478, 4085.428040074392, 4087.0, 4092.877213683594, 4104.774237416956, 4125.23683118621, 3574.4995700601935, 3679.521662183899, 3689.3543629864666, 3700.278445703089, 3710.8144592770254, 5088.77100530477, 5114.872128196787, 5117.1556693145585, 5121.359830021247, 5135.768890399941, 4722.5513576210205, 4727.45634252062, 4730.574248317668, 4749.26386410107, 4749.667523273372, 5129.204973229155, 5313.734313284321, 5394.595405344576, 5474.178873169017, 5484.424135465799, 3962.3858301962955, 3965.8810235692686, 3975.7813320267373, 3985.8405663773415, 4015.156817068419, 5639.915401268984, 5649.12438572022, 5650.067738823089, 5660.801871934463, 5663.969776169771, 3856.5757766645647, 4044.292248856438, 4093.836246550164, 4109.568495308009, 4128.566500517402, 4102.897427564275, 4103.7948102594755, 4105.4662893823615, 4122.8456032311005, 4159.441943204907, 4646.558576935186, 4660.7436590987145, 4689.780657029129, 4696.154692155376, 4697.496801023708, 5197.870053248699, 5457.508824205761, 5467.152591348347, 5489.890202195934, 5498.80754173602, 1418.2341535570677, 1438.388684808973, 1440.5678296511005, 1440.985590144085, 1444.1335198880588, 913.6665117232162, 935.5088578496344, 946.6024269806697, 946.98199435607, 956.6938579654444, 4672.275797251432, 4711.269753188261, 4719.504452032487, 4730.2431610942085, 4767.69010014348, 4911.287863259879, 4924.409070911442, 4939.456659767423, 4955.306257124005, 4986.177280748636, 4712.232912657753, 4738.763061846894, 4751.47952655147, 4798.688085274446, 4956.231784073474, 2890.8843646254336, 2959.496885529465, 2960.2155428811384, 2964.777641676883, 2975.0, 5749.039244788937, 5751.792123653996, 5760.452756988079, 5761.337446193657, 5770.653760774367, 5593.552515798727, 5696.601237913389, 5719.685417302088, 5741.684207368551, 5749.04532458966, 5755.366909639936, 5777.566682498746, 5781.889610292129, 5792.987646423836, 5793.333766616809, 5392.595555333287, 5500.0, 5568.777248909998, 5574.191742197439, 5587.580931430078, 5535.11438169907, 5552.69460179694, 5563.721813909207, 5568.303962004749, 5568.693721845338, 5696.401877802771, 5744.167095771007, 5759.56803239767, 5799.086301520572, 5807.186993820953, 3777.527809023872, 3871.264459752638, 3911.5110611173604, 3936.2717897189114, 3939.5666476688116, 5515.944840551543, 5544.916826247529, 5547.667139971614, 5548.500634942875, 5558.499735023867, 5430.429804870431, 5434.2935418395355, 5450.5367043801725, 5454.400015998158, 5461.754221059982, 5191.74041297926, 5408.78364865401, 5417.377001644703, 5423.728813559385, 5430.728463576885, 5376.274202982548, 5386.380566234933, 5396.811111611075, 5414.377346605191, 5415.891682166413, 5217.765200566059, 5401.918971215357, 5413.648112872651, 5421.536185230045, 5460.208269800936, 5343.492368225168, 5371.516563509303, 5386.13821788512, 5396.595255355785, 5399.325084364455], "value": 4142.106064002991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.734599525178, 710.5772065620957, 771.1440301265594, 774.337941060393, 826.7933016745814, 15091.924540377297, 15499.767503487457, 15529.456469023586, 15672.29474673641, 15698.92150539247, 14953.327100280487, 15151.166685832275, 15156.0, 15159.6968060639, 15167.62080947977, 774.6514068669107, 795.5187111797366, 798.8282519258358, 799.3125911715948, 799.5362689639995, 788.286600626434, 789.9052113746359, 790.4545863354267, 791.6595863778573, 791.9683212671487, 836.0552575589576, 844.0335815491259, 844.2823599940033, 849.6134258912211, 850.4047166983106, 845.6321500147425, 845.6575087089739, 846.2045677063571, 846.221476241859, 846.2299307630088, 623.8783437229743, 623.9937600624027, 624.4504835744516, 624.7969409941787, 624.8219257511632, 14276.500322488662, 14279.643008924757, 14285.357158927873, 14304.356303966346, 14309.78535321971, 12304.692382690504, 12566.371681415983, 12733.25688414968, 12793.168444051107, 13197.736045279136, 11080.16650196148, 11260.54957801687, 11286.887131128666, 11566.248193867372, 11593.362365070003, 3424.417848965682, 3487.5640544931885, 3503.9299214015577, 3526.6825985661158, 3552.1119720069983, 78898.0, 80048.59975700143, 80253.59873200655, 81052.59473702652, 81563.0, 8597.5701214939, 8718.346124040723, 8768.123187681182, 9364.765880853032, 9502.524873756423, 20144.39566812998, 20424.285150019678, 20515.589688206153, 20632.58734825295, 20634.0, 7895.328897043815, 8207.261346478846, 8276.503409795432, 8404.957975210085, 8834.0, 4700.670953033323, 4752.453467851172, 4847.781849816767, 4865.513448655106, 4917.311576379309, 3509.596396414394, 3588.69496092835, 3640.3265395901844, 3643.307771523402, 3643.872464463731, 586.0974099886128, 600.9008513595207, 609.1715267236555, 611.3153268339488, 630.6153246519619, 653.6568301641677, 666.4568376772914, 682.7405585877335, 686.1491750229679, 691.180950573572, 8752.474851508803, 9066.592003359865, 9379.671711490066, 9383.202427793578, 9672.806543869083, 552.3068548971015, 577.2265164679266, 611.9963260253188, 644.8065580325978, 653.7221680785647, 3828.8659896904032, 4116.608922152391, 4162.458880345596, 4441.089576636847, 4446.5331140230455, 86715.56642216875, 126223.368883155, 127304.36347818201, 128346.0, 128942.0, 69920.0, 105451.0, 106235.46882265694, 108057.4597127025, 109483.0, 84790.1520984807, 92176.53911730398, 93221.5338923301, 96454.03545964451, 96658.51670741601, 8730.825383492422, 8827.117288271122, 8876.644934202817, 9062.546872656472, 9387.812243755223, 49814.51298409077, 50148.498515014384, 50478.49521504738, 52255.81953443639, 52652.47347526476, 64210.357896420435, 64756.0, 66724.66289691154, 75456.24543754492, 76924.0, 11657.067434605042, 11882.940585297018, 11959.222650528036, 11980.64058078259, 12235.204711693712, 13843.653908652364, 14453.855461445251, 14887.181205033827, 14907.478238261609, 15025.248737562859, 12265.816012759995, 12533.686657833627, 12623.93688031554, 12816.295103769009, 13078.80381794293, 13726.036391854337, 14326.928365358106, 14402.855971440571, 14588.635284117558, 15018.399264029316, 11841.703957401134, 12079.879201207876, 13118.344082796013, 13730.862691373359, 14185.606910757726, 9829.627779165627, 9972.351797133164, 10259.897401025893, 10345.637902673672, 10633.946830266108, 9696.70909872705, 10002.199824013916, 10509.475023103583, 11513.712157196138, 12168.452419641315], "value": 7301.429560449068, "unit": "score"}], "name": "dromaeo_css", "value": 7079.13805735662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 123.0, 159.0, 121.0, 120.0, 119.0, 118.0, 154.0, 123.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 77.0, 75.0, 77.0, 76.0, 103.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 120.0, 84.0, 84.0, 83.0, 106.0, 83.0, 83.0, 118.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0, 148.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 52.0, 54.0, 53.0, 52.0, 54.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 63.0, 61.0, 61.0, 61.0, 61.0, 64.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 78.0, 78.0, 78.0, 80.0, 79.0, 87.0, 78.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 125.0, 131.0, 131.0, 134.0, 122.0, 121.0, 166.0, 134.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 168.0, 163.0, 165.0, 165.0, 164.0, 164.0, 170.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 65.0, 66.0, 68.0, 65.0, 69.0, 69.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1496.7, "alertThreshold": 2.0}]} 03:26:01 INFO - Return code: 0 03:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:26:01 INFO - # TBPL SUCCESS # 03:26:01 INFO - Running post-action listener: _resource_record_post_action 03:26:01 INFO - [mozharness: 2016-09-27 10:26:01.093203Z] Finished run-tests step (success) 03:26:01 INFO - Running post-run listener: _resource_record_post_run 03:26:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 395624448; Read time: 0; Write time: 320444 03:26:01 INFO - TinderboxPrint: CPU usage
13.1% 03:26:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:26:01 INFO - TinderboxPrint: I/O write bytes / time
395,624,448 / 320,444 03:26:01 INFO - TinderboxPrint: CPU idle
8,294.7 (86.9%) 03:26:01 INFO - TinderboxPrint: CPU user
1,196.9 (12.5%) 03:26:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:26:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106532864; Read time: 0; Write time: 72992 03:26:01 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288555008; Read time: 0; Write time: 247444 03:26:01 INFO - Running post-run listener: _upload_blobber_files 03:26:01 INFO - Blob upload gear active. 03:26:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:26:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:26:01 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:26:01 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:26:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:03 INFO - (blobuploader) - INFO - Done attempting. 03:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:04 INFO - (blobuploader) - INFO - Done attempting. 03:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:07 INFO - (blobuploader) - INFO - Done attempting. 03:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:07 INFO - Return code: 0 03:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/112ea780adb7a6e6f1539214e75e0c642a2399edbf71442b21818a672f45cfd168943e370fdca2037a86a5a726aaefe55b2298e3c2d992db8ec718b5fe76f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea155216112e53a14acee35c347ea923229e600fb0fa1987f7eda9a03e61a57c6b280c0edc3d6b9e67eb4f5679b87b5bf9d19d69af03df98b339b50e5cccd51a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bc9e4d4bc2b0bf5d5992f558e47a3a8ebf672435977a708b3c99449e1268cca72e34baae0e075e23a1ee8ac7fc2ce2be3ae930dc968691465bdf98164c8736"} 03:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:07 INFO - Contents: 03:26:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/112ea780adb7a6e6f1539214e75e0c642a2399edbf71442b21818a672f45cfd168943e370fdca2037a86a5a726aaefe55b2298e3c2d992db8ec718b5fe76f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea155216112e53a14acee35c347ea923229e600fb0fa1987f7eda9a03e61a57c6b280c0edc3d6b9e67eb4f5679b87b5bf9d19d69af03df98b339b50e5cccd51a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bc9e4d4bc2b0bf5d5992f558e47a3a8ebf672435977a708b3c99449e1268cca72e34baae0e075e23a1ee8ac7fc2ce2be3ae930dc968691465bdf98164c8736"} 03:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:07 INFO - Copying logs to upload dir... 03:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.987923 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-27 03:26:06.657368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:26:06.660917) ========= 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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/112ea780adb7a6e6f1539214e75e0c642a2399edbf71442b21818a672f45cfd168943e370fdca2037a86a5a726aaefe55b2298e3c2d992db8ec718b5fe76f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea155216112e53a14acee35c347ea923229e600fb0fa1987f7eda9a03e61a57c6b280c0edc3d6b9e67eb4f5679b87b5bf9d19d69af03df98b339b50e5cccd51a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bc9e4d4bc2b0bf5d5992f558e47a3a8ebf672435977a708b3c99449e1268cca72e34baae0e075e23a1ee8ac7fc2ce2be3ae930dc968691465bdf98164c8736"} build_url:https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/QdMJRvxGStWT9PTtx813vQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/112ea780adb7a6e6f1539214e75e0c642a2399edbf71442b21818a672f45cfd168943e370fdca2037a86a5a726aaefe55b2298e3c2d992db8ec718b5fe76f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea155216112e53a14acee35c347ea923229e600fb0fa1987f7eda9a03e61a57c6b280c0edc3d6b9e67eb4f5679b87b5bf9d19d69af03df98b339b50e5cccd51a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bc9e4d4bc2b0bf5d5992f558e47a3a8ebf672435977a708b3c99449e1268cca72e34baae0e075e23a1ee8ac7fc2ce2be3ae930dc968691465bdf98164c8736"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:26:06.690876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:26:06.691467) ========= 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=0e2a256762fed810e2f0f810000001b3-1474970726.144060-1984962259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:26:06.776509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:26:06.776871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:26:06.777202) ========= ========= Total master_lag: 0.21 =========