builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1475070021.93 results: success (0) buildid: 20160928033005 builduid: 1fdbba20a65a403986c4d3d3be9be1e8 revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:21.927849) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:21.928950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:21.929753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:21.947197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:21.947830) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 06:40:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-09-28 06:40:22 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:22.098055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:22.098798) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:22.151539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:40:22.152303) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45513d6773f099db66f0cd7bf1e312f6f9d11475 --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 45513d6773f099db66f0cd7bf1e312f6f9d11475 --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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 06:40:22,576 truncating revision to first 12 chars 2016-09-28 06:40:22,577 Setting DEBUG logging. 2016-09-28 06:40:22,577 attempt 1/10 2016-09-28 06:40:22,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45513d6773f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 06:40:23,818 unpacking tar archive at: fx-team-45513d6773f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.595347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:40:23.766985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:23.767781) ========= script_repo_revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:23.768785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:23.769511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:40:23.780994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-28 06:40:23.781707) ========= /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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:24 INFO - MultiFileLogger online at 20160928 06:40:24 in /builds/slave/test 06:40:24 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 06:40:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:24 INFO - {'append_to_log': False, 06:40:24 INFO - 'base_work_dir': '/builds/slave/test', 06:40:24 INFO - 'blob_upload_branch': 'Fx-Team', 06:40:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:24 INFO - 'branch': 'Fx-Team', 06:40:24 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:24 INFO - 'config_files': ('talos/linux_config.py',), 06:40:24 INFO - 'default_actions': ('clobber', 06:40:24 INFO - 'read-buildbot-config', 06:40:24 INFO - 'download-and-extract', 06:40:24 INFO - 'populate-webroot', 06:40:24 INFO - 'create-virtualenv', 06:40:24 INFO - 'install', 06:40:24 INFO - 'run-tests'), 06:40:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:24 INFO - 'download_minidump_stackwalk': True, 06:40:24 INFO - 'download_symbols': 'ondemand', 06:40:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:24 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:24 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:24 INFO - 'installer_path': 'installer.exe', 06:40:24 INFO - 'log_level': 'info', 06:40:24 INFO - 'log_name': 'talos', 06:40:24 INFO - 'log_to_console': True, 06:40:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:24 INFO - 'opt_config_files': (), 06:40:24 INFO - 'pip_index': False, 06:40:24 INFO - 'sps_profile': False, 06:40:24 INFO - 'sps_profile_interval': 0, 06:40:24 INFO - 'suite': 'dromaeojs', 06:40:24 INFO - 'system_bits': '32', 06:40:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:24 INFO - 'title': 'talos-linux64-ix-015', 06:40:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:24 INFO - 'use_talos_json': True, 06:40:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:24 INFO - 'work_dir': 'build'} 06:40:24 INFO - [mozharness: 2016-09-28 13:40:24.299293Z] Running clobber step. 06:40:24 INFO - Running pre-action listener: _resource_record_pre_action 06:40:24 INFO - Running main action method: clobber 06:40:24 INFO - rmtree: /builds/slave/test/build 06:40:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:40:24 INFO - Running post-action listener: _resource_record_post_action 06:40:24 INFO - [mozharness: 2016-09-28 13:40:24.752004Z] Finished clobber step (success) 06:40:24 INFO - [mozharness: 2016-09-28 13:40:24.752105Z] Running read-buildbot-config step. 06:40:24 INFO - Running pre-action listener: _resource_record_pre_action 06:40:24 INFO - Running main action method: read_buildbot_config 06:40:24 INFO - Using buildbot properties: 06:40:24 INFO - { 06:40:24 INFO - "project": "", 06:40:24 INFO - "product": "firefox", 06:40:24 INFO - "script_repo_revision": "production", 06:40:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:40:24 INFO - "repository": "", 06:40:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:40:24 INFO - "buildid": "20160928033005", 06:40:24 INFO - "pgo_build": "True", 06:40:24 INFO - "basedir": "/builds/slave/test", 06:40:24 INFO - "buildnumber": 484, 06:40:24 INFO - "slavename": "talos-linux64-ix-015", 06:40:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:40:24 INFO - "platform": "ubuntu64_hw", 06:40:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:40:24 INFO - "branch": "fx-team", 06:40:24 INFO - "repo_path": "integration/fx-team", 06:40:24 INFO - "revision": "45513d6773f099db66f0cd7bf1e312f6f9d11475", 06:40:24 INFO - "stage_platform": "linux64-pgo", 06:40:24 INFO - "builduid": "1fdbba20a65a403986c4d3d3be9be1e8", 06:40:24 INFO - "slavebuilddir": "test" 06:40:24 INFO - } 06:40:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:40:24 INFO - Running post-action listener: _resource_record_post_action 06:40:24 INFO - [mozharness: 2016-09-28 13:40:24.754536Z] Finished read-buildbot-config step (success) 06:40:24 INFO - [mozharness: 2016-09-28 13:40:24.754624Z] Running download-and-extract step. 06:40:24 INFO - Running pre-action listener: _resource_record_pre_action 06:40:24 INFO - Running main action method: download_and_extract 06:40:24 INFO - mkdir: /builds/slave/test/build/tests 06:40:24 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')]} 06:40:24 INFO - trying https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:40:24 INFO - Downloading https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/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 06:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/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 06:40:25 INFO - Downloaded 1361 bytes. 06:40:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:40:25 INFO - Using the following test package requirements: 06:40:25 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:40:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:40:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'jsshell-linux-x86_64.zip'], 06:40:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:40:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:40:25 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:40:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:40:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:40:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:40:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:40:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:40:25 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:40:25 INFO - Expected file size: 21984074 06:40:30 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 06:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:40:30 INFO - Expected file size: 21984074 06:40:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:40:36 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:40:36 INFO - Expected file size: 14414062 06:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:37 INFO - trying https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:40:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/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 06:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/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 06:40:40 INFO - Downloaded 59765697 bytes. 06:40:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:40:40 INFO - mkdir: /builds/slave/test/properties 06:40:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:40:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:40:40 INFO - Contents: 06:40:40 INFO - build_url:https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:40:41 INFO - Running post-action listener: _resource_record_post_action 06:40:41 INFO - Running post-action listener: set_extra_try_arguments 06:40:41 INFO - [mozharness: 2016-09-28 13:40:41.259155Z] Finished download-and-extract step (success) 06:40:41 INFO - [mozharness: 2016-09-28 13:40:41.259382Z] Running populate-webroot step. 06:40:41 INFO - Running pre-action listener: _resource_record_pre_action 06:40:41 INFO - Running main action method: populate_webroot 06:40:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:40:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:40:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:40:41 INFO - '--tppagecycles', 06:40:41 INFO - '7'], 06:40:41 INFO - 'tests': ['tsvgm']}}, 06:40:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:40:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:40:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:40:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:40:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['damp', 'tps']}, 06:40:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'tests': ['damp', 'tps']}, 06:40:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['dromaeo_dom']}, 06:40:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:40:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['basic_compositor_video']}, 06:40:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:40:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'other-e10s': {'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['a11yr', 06:40:41 INFO - 'ts_paint', 06:40:41 INFO - 'tpaint', 06:40:41 INFO - 'sessionrestore', 06:40:41 INFO - 'sessionrestore_no_auto_restore', 06:40:41 INFO - 'tabpaint']}, 06:40:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['tsvgx', 06:40:41 INFO - 'tsvgr_opacity', 06:40:41 INFO - 'tart', 06:40:41 INFO - 'tscrollx', 06:40:41 INFO - 'cart']}, 06:40:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:40:41 INFO - 'tsvgr_opacity', 06:40:41 INFO - 'tart', 06:40:41 INFO - 'tscrollx', 06:40:41 INFO - 'cart']}, 06:40:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'talos_options': ['--disable-e10s'], 06:40:41 INFO - 'tests': ['tp5o']}, 06:40:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'tests': ['tp5o']}, 06:40:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'talos_options': ['--disable-e10s', 06:40:41 INFO - '--xperf_path', 06:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:41 INFO - 'tests': ['tp5n']}, 06:40:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:41 INFO - 'talos_options': ['--xperf_path', 06:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:41 INFO - 'tests': ['tp5n']}}, 06:40:41 INFO - 'talos.zip': {'path': '', 06:40:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:40:41 INFO - Running post-action listener: _resource_record_post_action 06:40:41 INFO - [mozharness: 2016-09-28 13:40:41.275002Z] Finished populate-webroot step (success) 06:40:41 INFO - [mozharness: 2016-09-28 13:40:41.275091Z] Running create-virtualenv step. 06:40:41 INFO - Running pre-action listener: _resource_record_pre_action 06:40:41 INFO - Running main action method: create_virtualenv 06:40:41 INFO - Creating virtualenv /builds/slave/test/build/venv 06:40:41 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 06:40:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:40:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:40:41 INFO - Using real prefix '/usr' 06:40:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:40:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:40:43 INFO - Installing pip.................done. 06:40:43 INFO - Return code: 0 06:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:40:44 INFO - Reading from file tmpfile_stdout 06:40:44 INFO - Output received: 06:40:44 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) 06:40:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:40:44 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')]} 06:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:44 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')]} 06:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:44 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:44 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 06:40:44 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 06:40:44 INFO - Using env: {'DISPLAY': ':0', 06:40:44 INFO - 'HOME': '/home/cltbld', 06:40:44 INFO - 'LANG': 'en_US.UTF-8', 06:40:44 INFO - 'LANGUAGE': 'en_US:en', 06:40:44 INFO - 'LOGNAME': 'cltbld', 06:40:44 INFO - 'MAIL': '/var/mail/cltbld', 06:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:44 INFO - 'MOZ_NO_REMOTE': '1', 06:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:44 INFO - 'NO_EM_RESTART': '1', 06:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:44 INFO - 'PWD': '/builds/slave/test', 06:40:44 INFO - 'SHELL': '/bin/bash', 06:40:44 INFO - 'SHLVL': '1', 06:40:44 INFO - 'TERM': 'linux', 06:40:44 INFO - 'TMOUT': '86400', 06:40:44 INFO - 'USER': 'cltbld', 06:40:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:44 INFO - '_': '/tools/buildbot/bin/python'} 06:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:44 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 06:40:44 INFO - Cleaning up... 06:40:44 INFO - Return code: 0 06:40:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:40:44 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')]} 06:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:44 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')]} 06:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:44 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:44 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 06:40:44 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 06:40:44 INFO - Using env: {'DISPLAY': ':0', 06:40:44 INFO - 'HOME': '/home/cltbld', 06:40:44 INFO - 'LANG': 'en_US.UTF-8', 06:40:44 INFO - 'LANGUAGE': 'en_US:en', 06:40:44 INFO - 'LOGNAME': 'cltbld', 06:40:44 INFO - 'MAIL': '/var/mail/cltbld', 06:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:44 INFO - 'MOZ_NO_REMOTE': '1', 06:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:44 INFO - 'NO_EM_RESTART': '1', 06:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:44 INFO - 'PWD': '/builds/slave/test', 06:40:44 INFO - 'SHELL': '/bin/bash', 06:40:44 INFO - 'SHLVL': '1', 06:40:44 INFO - 'TERM': 'linux', 06:40:44 INFO - 'TMOUT': '86400', 06:40:44 INFO - 'USER': 'cltbld', 06:40:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:44 INFO - '_': '/tools/buildbot/bin/python'} 06:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:44 INFO - Downloading/unpacking psutil>=3.1.1 06:40:44 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 06:40:44 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 06:40:44 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 06:40:44 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 06:40:44 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 06:40:44 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 06:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:46 INFO - Installing collected packages: psutil 06:40:46 INFO - Running setup.py install for psutil 06:40:46 INFO - building 'psutil._psutil_linux' extension 06:40:46 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 06:40:46 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 06:40:46 INFO - building 'psutil._psutil_posix' extension 06:40:46 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 06:40:46 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 06:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:46 INFO - Successfully installed psutil 06:40:46 INFO - Cleaning up... 06:40:47 INFO - Return code: 0 06:40:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:40:47 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')]} 06:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:47 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')]} 06:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:47 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:47 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 06:40:47 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 06:40:47 INFO - Using env: {'DISPLAY': ':0', 06:40:47 INFO - 'HOME': '/home/cltbld', 06:40:47 INFO - 'LANG': 'en_US.UTF-8', 06:40:47 INFO - 'LANGUAGE': 'en_US:en', 06:40:47 INFO - 'LOGNAME': 'cltbld', 06:40:47 INFO - 'MAIL': '/var/mail/cltbld', 06:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:47 INFO - 'MOZ_NO_REMOTE': '1', 06:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:47 INFO - 'NO_EM_RESTART': '1', 06:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:47 INFO - 'PWD': '/builds/slave/test', 06:40:47 INFO - 'SHELL': '/bin/bash', 06:40:47 INFO - 'SHLVL': '1', 06:40:47 INFO - 'TERM': 'linux', 06:40:47 INFO - 'TMOUT': '86400', 06:40:47 INFO - 'USER': 'cltbld', 06:40:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:47 INFO - '_': '/tools/buildbot/bin/python'} 06:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:40:47 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 06:40:47 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 06:40:47 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 06:40:47 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 06:40:47 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 06:40:47 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 06:40:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:40:49 INFO - Installing collected packages: mozsystemmonitor 06:40:49 INFO - Running setup.py install for mozsystemmonitor 06:40:49 INFO - Successfully installed mozsystemmonitor 06:40:49 INFO - Cleaning up... 06:40:49 INFO - Return code: 0 06:40:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:49 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:49 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 06:40:49 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 06:40:49 INFO - Using env: {'DISPLAY': ':0', 06:40:49 INFO - 'HOME': '/home/cltbld', 06:40:49 INFO - 'LANG': 'en_US.UTF-8', 06:40:49 INFO - 'LANGUAGE': 'en_US:en', 06:40:49 INFO - 'LOGNAME': 'cltbld', 06:40:49 INFO - 'MAIL': '/var/mail/cltbld', 06:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:49 INFO - 'MOZ_NO_REMOTE': '1', 06:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:49 INFO - 'NO_EM_RESTART': '1', 06:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:49 INFO - 'PWD': '/builds/slave/test', 06:40:49 INFO - 'SHELL': '/bin/bash', 06:40:49 INFO - 'SHLVL': '1', 06:40:49 INFO - 'TERM': 'linux', 06:40:49 INFO - 'TMOUT': '86400', 06:40:49 INFO - 'USER': 'cltbld', 06:40:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:49 INFO - '_': '/tools/buildbot/bin/python'} 06:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:49 INFO - Downloading/unpacking jsonschema==2.5.1 06:40:49 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 06:40:49 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 06:40:49 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 06:40:49 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 06:40:49 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 06:40:49 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 06:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:40:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:40:51 INFO - warning: no files found matching '*.txt' 06:40:51 INFO - no previously-included directories found matching 'build' 06:40:51 INFO - no previously-included directories found matching 'dist' 06:40:51 INFO - no previously-included directories found matching '.git*' 06:40:51 INFO - Installing collected packages: jsonschema, functools32 06:40:51 INFO - Running setup.py install for functools32 06:40:51 INFO - warning: no files found matching '*.txt' 06:40:51 INFO - no previously-included directories found matching 'build' 06:40:51 INFO - no previously-included directories found matching 'dist' 06:40:51 INFO - no previously-included directories found matching '.git*' 06:40:51 INFO - Successfully installed jsonschema functools32 06:40:51 INFO - Cleaning up... 06:40:51 INFO - Return code: 0 06:40:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:51 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 06:40:51 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 06:40:51 INFO - Using env: {'DISPLAY': ':0', 06:40:51 INFO - 'HOME': '/home/cltbld', 06:40:51 INFO - 'LANG': 'en_US.UTF-8', 06:40:51 INFO - 'LANGUAGE': 'en_US:en', 06:40:51 INFO - 'LOGNAME': 'cltbld', 06:40:51 INFO - 'MAIL': '/var/mail/cltbld', 06:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:51 INFO - 'MOZ_NO_REMOTE': '1', 06:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:51 INFO - 'NO_EM_RESTART': '1', 06:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:51 INFO - 'PWD': '/builds/slave/test', 06:40:51 INFO - 'SHELL': '/bin/bash', 06:40:51 INFO - 'SHLVL': '1', 06:40:51 INFO - 'TERM': 'linux', 06:40:51 INFO - 'TMOUT': '86400', 06:40:51 INFO - 'USER': 'cltbld', 06:40:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:51 INFO - '_': '/tools/buildbot/bin/python'} 06:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:40:52 INFO - Cleaning up... 06:40:52 INFO - Return code: 0 06:40:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:40:52 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')]} 06:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:52 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')]} 06:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:52 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:52 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 06:40:52 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 06:40:52 INFO - Using env: {'DISPLAY': ':0', 06:40:52 INFO - 'HOME': '/home/cltbld', 06:40:52 INFO - 'LANG': 'en_US.UTF-8', 06:40:52 INFO - 'LANGUAGE': 'en_US:en', 06:40:52 INFO - 'LOGNAME': 'cltbld', 06:40:52 INFO - 'MAIL': '/var/mail/cltbld', 06:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:52 INFO - 'MOZ_NO_REMOTE': '1', 06:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:52 INFO - 'NO_EM_RESTART': '1', 06:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:52 INFO - 'PWD': '/builds/slave/test', 06:40:52 INFO - 'SHELL': '/bin/bash', 06:40:52 INFO - 'SHLVL': '1', 06:40:52 INFO - 'TERM': 'linux', 06:40:52 INFO - 'TMOUT': '86400', 06:40:52 INFO - 'USER': 'cltbld', 06:40:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:52 INFO - '_': '/tools/buildbot/bin/python'} 06:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:40:52 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 06:40:52 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 06:40:52 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 06:40:52 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 06:40:52 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 06:40:52 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 06:40:54 INFO - Downloading blobuploader-1.2.4.tar.gz 06:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:40:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:40:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:54 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 06:40:55 INFO - Downloading docopt-0.6.1.tar.gz 06:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:40:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:40:55 INFO - Running setup.py install for blobuploader 06:40:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:40:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:40:55 INFO - Running setup.py install for requests 06:40:55 INFO - Running setup.py install for docopt 06:40:55 INFO - Successfully installed blobuploader requests docopt 06:40:55 INFO - Cleaning up... 06:40:55 INFO - Return code: 0 06:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:55 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:55 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 06:40:55 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 06:40:55 INFO - Using env: {'DISPLAY': ':0', 06:40:55 INFO - 'HOME': '/home/cltbld', 06:40:55 INFO - 'LANG': 'en_US.UTF-8', 06:40:55 INFO - 'LANGUAGE': 'en_US:en', 06:40:55 INFO - 'LOGNAME': 'cltbld', 06:40:55 INFO - 'MAIL': '/var/mail/cltbld', 06:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:55 INFO - 'MOZ_NO_REMOTE': '1', 06:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:55 INFO - 'NO_EM_RESTART': '1', 06:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:55 INFO - 'PWD': '/builds/slave/test', 06:40:55 INFO - 'SHELL': '/bin/bash', 06:40:55 INFO - 'SHLVL': '1', 06:40:55 INFO - 'TERM': 'linux', 06:40:55 INFO - 'TMOUT': '86400', 06:40:55 INFO - 'USER': 'cltbld', 06:40:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:55 INFO - '_': '/tools/buildbot/bin/python'} 06:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:56 INFO - Running setup.py (path:/tmp/pip-KA7ayE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:56 INFO - Running setup.py (path:/tmp/pip-J7C9Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:56 INFO - Running setup.py (path:/tmp/pip-Bg3mAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:56 INFO - Running setup.py (path:/tmp/pip-aiKFZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:56 INFO - Running setup.py (path:/tmp/pip-FBEtoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:56 INFO - Running setup.py (path:/tmp/pip-8quru0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:56 INFO - Running setup.py (path:/tmp/pip-ycdKwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:56 INFO - Running setup.py (path:/tmp/pip-OuLWji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:56 INFO - Running setup.py (path:/tmp/pip-IG1jX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:56 INFO - Running setup.py (path:/tmp/pip-H8QlKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:56 INFO - Running setup.py (path:/tmp/pip-1dBvb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:56 INFO - Running setup.py (path:/tmp/pip-wPJCCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:56 INFO - Running setup.py (path:/tmp/pip-AqIXnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:56 INFO - Running setup.py (path:/tmp/pip-08M9L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:57 INFO - Running setup.py (path:/tmp/pip-JgnYEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:57 INFO - Running setup.py (path:/tmp/pip-m_4dMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:57 INFO - Running setup.py (path:/tmp/pip-aiAYel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:40:57 INFO - Running setup.py install for manifestparser 06:40:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:40:57 INFO - Running setup.py install for mozcrash 06:40:57 INFO - Running setup.py install for mozdebug 06:40:57 INFO - Running setup.py install for mozdevice 06:40:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:40:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:40:57 INFO - Running setup.py install for mozfile 06:40:57 INFO - Running setup.py install for mozhttpd 06:40:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:40:57 INFO - Running setup.py install for mozinfo 06:40:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:40:57 INFO - Running setup.py install for mozInstall 06:40:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Running setup.py install for mozleak 06:40:58 INFO - Running setup.py install for mozlog 06:40:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Running setup.py install for moznetwork 06:40:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Running setup.py install for mozprocess 06:40:58 INFO - Running setup.py install for mozprofile 06:40:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Running setup.py install for mozrunner 06:40:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:40:58 INFO - Running setup.py install for mozscreenshot 06:40:58 INFO - Running setup.py install for moztest 06:40:58 INFO - Running setup.py install for mozversion 06:40:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:40:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:40:59 INFO - Cleaning up... 06:40:59 INFO - Return code: 0 06:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:59 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')]} 06:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:59 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')]} 06:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:59 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:40:59 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 06:40:59 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 06:40:59 INFO - Using env: {'DISPLAY': ':0', 06:40:59 INFO - 'HOME': '/home/cltbld', 06:40:59 INFO - 'LANG': 'en_US.UTF-8', 06:40:59 INFO - 'LANGUAGE': 'en_US:en', 06:40:59 INFO - 'LOGNAME': 'cltbld', 06:40:59 INFO - 'MAIL': '/var/mail/cltbld', 06:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:59 INFO - 'MOZ_NO_REMOTE': '1', 06:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:59 INFO - 'NO_EM_RESTART': '1', 06:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:59 INFO - 'PWD': '/builds/slave/test', 06:40:59 INFO - 'SHELL': '/bin/bash', 06:40:59 INFO - 'SHLVL': '1', 06:40:59 INFO - 'TERM': 'linux', 06:40:59 INFO - 'TMOUT': '86400', 06:40:59 INFO - 'USER': 'cltbld', 06:40:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:59 INFO - '_': '/tools/buildbot/bin/python'} 06:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:59 INFO - Running setup.py (path:/tmp/pip-0_yfpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:59 INFO - Running setup.py (path:/tmp/pip-F2SIq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:59 INFO - Running setup.py (path:/tmp/pip-xdqSe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:59 INFO - Running setup.py (path:/tmp/pip-yDUAPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:59 INFO - Running setup.py (path:/tmp/pip-Y92N8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:59 INFO - Running setup.py (path:/tmp/pip-dDhKwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:59 INFO - Running setup.py (path:/tmp/pip-lbXAye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:59 INFO - Running setup.py (path:/tmp/pip-woomI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:59 INFO - Running setup.py (path:/tmp/pip-U49fZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:59 INFO - Running setup.py (path:/tmp/pip-0ylYVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:59 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)) 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:59 INFO - Running setup.py (path:/tmp/pip-QcxMjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:00 INFO - Running setup.py (path:/tmp/pip-opdPgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:00 INFO - Running setup.py (path:/tmp/pip-0_NrNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:00 INFO - Running setup.py (path:/tmp/pip-7pUElC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:00 INFO - Running setup.py (path:/tmp/pip-5sp0n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:00 INFO - Running setup.py (path:/tmp/pip-4PvOy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:00 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)) 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:00 INFO - Running setup.py (path:/tmp/pip-iZd9rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:00 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)) 06:41:00 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)) 06:41:00 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)) 06:41:00 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)) 06:41:00 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)) 06:41:00 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)) 06:41:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:00 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 06:41:00 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 06:41:00 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 06:41:00 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 06:41:00 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 06:41:00 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 06:41:02 INFO - Downloading blessings-1.6.tar.gz 06:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:02 INFO - Installing collected packages: blessings 06:41:02 INFO - Running setup.py install for blessings 06:41:02 INFO - Successfully installed blessings 06:41:02 INFO - Cleaning up... 06:41:02 INFO - Return code: 0 06:41:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:02 INFO - Reading from file tmpfile_stdout 06:41:02 INFO - Current package versions: 06:41:02 INFO - argparse == 1.2.1 06:41:02 INFO - blessings == 1.6 06:41:02 INFO - blobuploader == 1.2.4 06:41:02 INFO - docopt == 0.6.1 06:41:02 INFO - functools32 == 3.2.3-2 06:41:02 INFO - jsonschema == 2.5.1 06:41:02 INFO - manifestparser == 1.1 06:41:02 INFO - mozInstall == 1.12 06:41:02 INFO - mozcrash == 0.17 06:41:02 INFO - mozdebug == 0.1 06:41:02 INFO - mozdevice == 0.48 06:41:02 INFO - mozfile == 1.2 06:41:02 INFO - mozhttpd == 0.7 06:41:02 INFO - mozinfo == 0.9 06:41:02 INFO - mozleak == 0.1 06:41:02 INFO - mozlog == 3.4 06:41:02 INFO - moznetwork == 0.27 06:41:02 INFO - mozprocess == 0.23 06:41:02 INFO - mozprofile == 0.28 06:41:02 INFO - mozrunner == 6.12 06:41:02 INFO - mozscreenshot == 0.1 06:41:02 INFO - mozsystemmonitor == 0.3 06:41:02 INFO - moztest == 0.7 06:41:02 INFO - mozversion == 1.4 06:41:02 INFO - psutil == 3.1.1 06:41:02 INFO - requests == 1.2.3 06:41:02 INFO - wsgiref == 0.1.2 06:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:02 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 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:41:02 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 06:41:02 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 06:41:02 INFO - Using env: {'DISPLAY': ':0', 06:41:02 INFO - 'HOME': '/home/cltbld', 06:41:02 INFO - 'LANG': 'en_US.UTF-8', 06:41:02 INFO - 'LANGUAGE': 'en_US:en', 06:41:02 INFO - 'LOGNAME': 'cltbld', 06:41:02 INFO - 'MAIL': '/var/mail/cltbld', 06:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:02 INFO - 'MOZ_NO_REMOTE': '1', 06:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:02 INFO - 'NO_EM_RESTART': '1', 06:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:02 INFO - 'PWD': '/builds/slave/test', 06:41:02 INFO - 'SHELL': '/bin/bash', 06:41:02 INFO - 'SHLVL': '1', 06:41:02 INFO - 'TERM': 'linux', 06:41:02 INFO - 'TMOUT': '86400', 06:41:02 INFO - 'USER': 'cltbld', 06:41:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:02 INFO - '_': '/tools/buildbot/bin/python'} 06:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 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)) 06:41:03 INFO - Cleaning up... 06:41:03 INFO - Return code: 0 06:41:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b0911f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d12790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', '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 06:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:41:03 INFO - Using env: {'DISPLAY': ':0', 06:41:03 INFO - 'HOME': '/home/cltbld', 06:41:03 INFO - 'LANG': 'en_US.UTF-8', 06:41:03 INFO - 'LANGUAGE': 'en_US:en', 06:41:03 INFO - 'LOGNAME': 'cltbld', 06:41:03 INFO - 'MAIL': '/var/mail/cltbld', 06:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:03 INFO - 'MOZ_NO_REMOTE': '1', 06:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:03 INFO - 'NO_EM_RESTART': '1', 06:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:03 INFO - 'PWD': '/builds/slave/test', 06:41:03 INFO - 'SHELL': '/bin/bash', 06:41:03 INFO - 'SHLVL': '1', 06:41:03 INFO - 'TERM': 'linux', 06:41:03 INFO - 'TMOUT': '86400', 06:41:03 INFO - 'USER': 'cltbld', 06:41:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:03 INFO - '_': '/tools/buildbot/bin/python'} 06:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:41:03 INFO - Cleaning up... 06:41:03 INFO - Return code: 0 06:41:03 INFO - Running post-action listener: _resource_record_post_action 06:41:03 INFO - Running post-action listener: _start_resource_monitoring 06:41:03 INFO - Starting resource monitoring. 06:41:03 INFO - [mozharness: 2016-09-28 13:41:03.333190Z] Finished create-virtualenv step (success) 06:41:03 INFO - [mozharness: 2016-09-28 13:41:03.333658Z] Running install step. 06:41:03 INFO - Running pre-action listener: _resource_record_pre_action 06:41:03 INFO - Running main action method: install 06:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:03 INFO - Reading from file tmpfile_stdout 06:41:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:03 INFO - Reading from file tmpfile_stdout 06:41:03 INFO - Output received: 06:41:03 INFO - Usage: mozinstall [options] installer 06:41:03 INFO - Options: 06:41:03 INFO - -h, --help show this help message and exit 06:41:03 INFO - -d DEST, --destination=DEST 06:41:03 INFO - Directory to install application into. [default: 06:41:03 INFO - "/builds/slave/test"] 06:41:03 INFO - --app=APP Application being installed. [default: firefox] 06:41:03 INFO - mkdir: /builds/slave/test/build/application 06:41:03 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'] 06:41:03 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 06:41:20 INFO - Reading from file tmpfile_stdout 06:41:20 INFO - Output received: 06:41:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:41:20 INFO - Running post-action listener: _resource_record_post_action 06:41:20 INFO - [mozharness: 2016-09-28 13:41:20.653428Z] Finished install step (success) 06:41:20 INFO - [mozharness: 2016-09-28 13:41:20.653672Z] Running run-tests step. 06:41:20 INFO - Running pre-action listener: _resource_record_pre_action 06:41:20 INFO - Running main action method: run_tests 06:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:41:20 INFO - Python 2.7.3 06:41:20 INFO - Return code: 0 06:41:20 INFO - grabbing minidump binary from tooltool 06:41:20 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')]} 06:41:20 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 0x1d0f930>, '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 0x1d10830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d10cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:41:20 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 06:41:20 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 06:41:20 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 06:41:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:20 INFO - Return code: 0 06:41:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:41:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:41:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:41:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:41:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:41:20 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/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 06:41:20 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/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 06:41:20 INFO - Using env: {'DISPLAY': ':0', 06:41:20 INFO - 'HOME': '/home/cltbld', 06:41:20 INFO - 'LANG': 'en_US.UTF-8', 06:41:20 INFO - 'LANGUAGE': 'en_US:en', 06:41:20 INFO - 'LOGNAME': 'cltbld', 06:41:20 INFO - 'MAIL': '/var/mail/cltbld', 06:41:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:41:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:20 INFO - 'MOZ_NO_REMOTE': '1', 06:41:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:20 INFO - 'NO_EM_RESTART': '1', 06:41:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:20 INFO - 'PWD': '/builds/slave/test', 06:41:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:41:20 INFO - 'SHELL': '/bin/bash', 06:41:20 INFO - 'SHLVL': '1', 06:41:20 INFO - 'TERM': 'linux', 06:41:20 INFO - 'TMOUT': '86400', 06:41:20 INFO - 'USER': 'cltbld', 06:41:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498', 06:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:20 INFO - '_': '/tools/buildbot/bin/python'} 06:41:20 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/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 06:41:20 INFO - mozversion application_buildid: 20160928033005 06:41:20 INFO - mozversion application_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 06:41:20 INFO - mozversion application_display_name: Nightly 06:41:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:20 INFO - mozversion application_name: Firefox 06:41:20 INFO - mozversion application_remotingname: firefox 06:41:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:41:20 INFO - mozversion application_vendor: Mozilla 06:41:20 INFO - mozversion application_version: 52.0a1 06:41:20 INFO - mozversion platform_buildid: 20160928033005 06:41:20 INFO - mozversion platform_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 06:41:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:41:20 INFO - mozversion platform_version: 52.0a1 06:41:20 INFO - using testdate: 1475070080 06:41:20 INFO - actual date: 1475070080 06:41:20 INFO - starting webserver on 'localhost:55220' 06:41:20 INFO - SUITE-START | Running 2 tests 06:41:20 INFO - TEST-START | dromaeo_css 06:41:20 INFO - operating with platform_type : linux_ 06:41:20 INFO - Initialising browser for dromaeo_css test... 06:41:20 INFO - TEST-INFO | started process 30677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9vCnk/profile http://localhost:55220/getInfo.html) 06:41:25 INFO - PROCESS | 30677 | __metrics Screen width/height:1600/1200 06:41:25 INFO - PROCESS | 30677 | colorDepth:24 06:41:25 INFO - PROCESS | 30677 | Browser inner width/height: 1024/697 06:41:25 INFO - PROCESS | 30677 | __metrics 06:41:25 INFO - PROCESS | 30677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:41:25 INFO - PROCESS | 30677 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:41:25 INFO - PROCESS | 30677 | console.error: PushService: 06:41:25 INFO - PROCESS | 30677 | stateChangeProcessEnqueue: Error transitioning state 06:41:25 INFO - PROCESS | 30677 | UnknownError 06:41:26 INFO - TEST-INFO | 30677: exit 0 06:41:26 INFO - Browser initialized. 06:41:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:41:26 INFO - TEST-INFO | started process 30762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9vCnk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:38 INFO - PROCESS | 30762 | RSS: Main: 173350912 06:41:38 INFO - PROCESS | 30762 | 06:42:30 INFO - PROCESS | 30762 | 1475070150204 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] 06:44:39 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55220/tests/dromaeo/cssquery-ext.html) 06:44:41 INFO - PROCESS | 30762 | RSS: Main: 326402048 06:44:41 INFO - PROCESS | 30762 | 06:47:43 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-ext.html (next: http://localhost:55220/tests/dromaeo/cssquery-jquery.html) 06:47:44 INFO - PROCESS | 30762 | RSS: Main: 285155328 06:47:44 INFO - PROCESS | 30762 | 06:50:46 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55220/tests/dromaeo/cssquery-mootools.html) 06:50:46 INFO - PROCESS | 30762 | RSS: Main: 217223168 06:50:46 INFO - PROCESS | 30762 | 06:53:48 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55220/tests/dromaeo/cssquery-prototype.html) 06:53:49 INFO - PROCESS | 30762 | RSS: Main: 214364160 06:53:49 INFO - PROCESS | 30762 | 06:56:52 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55220/tests/dromaeo/cssquery-yui.html) 06:56:52 INFO - PROCESS | 30762 | RSS: Main: 215519232 06:56:52 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | Cycle 1(1): loaded http://localhost:55220/tests/dromaeo/cssquery-yui.html (next: http://localhost:55220/tests/dromaeo/cssquery-dojo.html) 06:59:55 INFO - PROCESS | 30762 | RSS: Main: 308629504 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | __start_tp_report 06:59:55 INFO - PROCESS | 30762 | _x_x_mozilla_page_load 06:59:55 INFO - PROCESS | 30762 | _x_x_mozilla_page_load_details 06:59:55 INFO - PROCESS | 30762 | |i|pagename|runs| 06:59:55 INFO - PROCESS | 30762 | |0;dojo.html;3063.9387212255756;3093.613298337708;3094.1645755645977;3120.734737547308;3150.54317124017;5261.86845328866;5314.202869569566;5352.30420045394;5418.674879507233;5420.1327787554;5397.676139431637;5429.158480435539;5430.212619170218;5477;5507.642003269784;4888.902221955576;4907.018596280758;4932.432770231433;4942.184539550988;5007.799688012475;5032;5035.093683137034;5035.597152227813;5037.874053148664;5042.873928151807;4808.927866082012;4815.518448155191;4862.36789217403;5016.247562865563;5028.245763135541;4874.53691899269;4963.1810751226;4966.031623833354;4987.650864439491;4988.276699878534;4836.975815120902;4860.659753817235;4872.756362181876;4890.486498917598;4927.950720492785;5425.37608175061;5426.701531415771;5428.647137936022;5436.293281873371;5437.891242175174;5689.516391106761;5693.686847223401;5723.112917497794;5736;5740.655560666331;5773.88452230953;5788.594798364116;5800.8259752207505;5801.593888427812;5850.122481627747;5406.783728650849;5409.648372855751;5411.5129638331955;5413.485718856702;5416.972915135439;5790.276215473066;5800.767969281266;5861.032929566573;5895.911561326584;5938.851528711817;5656.943430565641;5693.772249109989;5706.457886500776;5707.914381284284;5715.114157305624;5802.1296805479515;5857.502112320415;5858.091995740667;5867.413258674099;5944.464998150187;5841.853953651193;5854.121881717776;5855.3266374367495;5857.238558987305;5857.47282744555;5648.971755141198;5819.505342045889;5853.443922827325;5856.238688970407;5864.120381942657;4439.289713645801;4445.244308467568;4475.686701930834;4476.955230447719;4527.501974782771;3959.109200429938;3975.284448799186;3976.1451287973223;4016.3373043448087;4017.6986725995666;5436.10304299794;5479.726013699299;5490.752916118784;5496.890062198733;5503.284573005483;5705.4579814917515;5727.6849773262875;5738.655680659173;5790.478856902899;5793.971030144822;5498.725063746797;5501.9174712379345;5505.532029777433;5531.889362212733;5564.4991950724625;4910.386201724785;4941.802327906916;4944.406671199479;4944.522675295375;4996.375453068366;5881.9705901470215;5918.526517878646;5927.436893495111;6036.3360030396625;6041.667708276087;5773.3072031356505;5798.246227990334;5807.970960145172;5827.912581311199;5828.0966450200285;5972.522198224045;5984.16221728967;5999.070144127667;6006.219191505076;6042.879142417215;5737.368889422077;5739.655620662774;5752.424757524214;5752.6836024019085;5769.451902069297;5795.7539129087445;5820.330661973758;5825.446582574648;5825.59220854553;5848.327442344014;5437.293151890229;5467.125259958388;5510.559155267649;5529.474699903502;5554.055810512142;5553.972230138824;5554.888902222014;5555.30558680165;5559.193916881949;5610.943890561042;5440.510354068153;5479.726013699219;5487;5502.0921547944145;5557.888842223214;5583.860403489945;5603.971980140073;5638.37977822431;5652.7738890443925;5671.517920976763;5523.1991361253195;5523.392426833126;5544.085225937675;5564.276644036249;5581.944180558143 06:59:55 INFO - PROCESS | 30762 | |1;ext.html;554.1780679831277;592.2241863159262;610.5512448350462;618.7648693496468;634.7968650031992;32349.441561428255;42412.15175696488;43426.56573434265;43450.782746086225;43538.56461435385;44987.550124498746;44997;45234.321485177665;45243;45304;8820.955895220532;8956.686515971942;8958.86561701575;8965.372423930296;8989.910100899006;8630.309575233998;8745.169208925174;8748.25639820616;8752.862127923392;8771.649134034631;8757.211850933414;8784;8807.95596022019;8816.955915220447;8817.779555511099;8696.086910874363;8737.257333126692;8760.737177884674;8764;8825.338099642488;8552.743417697478;8890.377673562853;8901.554922253861;8904.910950890539;8909.688160914402;42258.78870605627;42535.1492970142;42560.78719606382;42667.35998960018;42673.78663106664;3406.148462884279;3500.912477188065;3592.8203589820405;3848.4804551385487;4029.294873397173;31634.525482117788;31856.20359491008;31904.361912761615;32507.512387314207;33576.83211583951;4363.47638283408;4374.300111982067;4434.11317736454;4659.697119687244;4670.859874203779;315271;349893;350486;350832;351002.244988776;62336.68831655903;63301.68349158225;63382.366176337644;63387;63419.68290158612;64096.35903640997;64463.355366446674;64564.35435645677;64972.35027649758;64991;14969.550913472613;15125.243737813065;15175.544733658007;15199.924000379928;15206.695866082617;11420.486078126338;11515;11516.884831151581;11522.193446458836;11528.135389845795;19026.61946761057;19106.426807195807;19194;19314.613707726046;19550.217991280475;6968.512204145661;7475.514091584029;7499;7576.7348142814735;7664.80837979055;883.1212943121507;960.8668755363083;964.6961207219704;999.6001599360314;1008.6721815410021;30391.240218994702;32196;33044.83477582597;34693.653063469545;34724.65275347214;1020.403064207447;1070.6306324318255;1093.748437859281;1105.8175401058895;1138.3568283919558;15805;16467.58831029234;16702;16746.162691865356;16769.32922683079;493551;497839;497948;498341;498653;50573;51000;51061.744691276304;51076.74461627742;51100.74449627728;1192.4335940428227;1223.7736018836545;1241.2118304876287;1275.929823859678;1324.4238756140917;27612.861935690195;30125.849370753007;31868.203294917814;34144.48783268303;34374.65625343715;53214.4678553225;53698.73150634222;53935.46064539461;54019;54028;454429;455966;460201;460212;460391;27994.300142496602;28053.57919631248;28565.857170714015;28568.85715571409;28582.428351432438;43974;46638.30042549297;47901.76049119732;47947.76026119847;47950.520494794604;38582;39150.80424597859;39818.60181398149;40928.38607420831;41204.58795412127;39500.604993950845;39547.2090558193;40448;40509.189816202925;41193.58806412017;35512.112197195274;35725.821370892976;38032.23935521219;40887.59112408838;41015.589844101174;30466.84766576153;35404.46893296551;36737.632623673424;36892.26215475729;42758.358624620036;31655.84172079125;31953.360932781678;33533.16167095842;33601.327973440886;33691.66308336984 06:59:55 INFO - PROCESS | 30762 | |2;jquery.html;378.05863400133677;380.87621523005015;388.578392444198;395.33780916964076;414.4756882543583;13479.460821567138;14179.503717369895;15935.76096358554;18876.433706988777;18880.716789248174;17397.217125229363;18020.098995050226;18111.366102186425;18130.3654372097;18249.36127235547;5548.250986116883;5788.305403351604;5789.942100579004;5802.245708057946;5806.912896306559;5509.47659972304;5675.602707810434;5754.597178197528;5779.653220806765;5870.501007414375;5855.151003104547;5857.121431785245;5860.736266868002;5866.5306775458075;5866.560007999396;5680.289963754531;5815.040518314473;5845.09401042839;5857.619254748471;5858.619189752652;5507.972460137674;5679.062954612526;5681.602287839853;5682.261306030189;5698.487136157766;13309.667258318523;13410.86589134106;13539.932300338534;13543.255120968342;13559;2291.8281128915232;2497.2008957133726;2698.541247987847;2704.2506038496817;2714.5113879501682;9450.810983780355;9463;9720.562574684156;10085.798284034277;10335.483225838752;1788.4545213709814;1804.3323970131135;1877.3804644467293;1879.1074239736015;1897.1936926806052;73818.26181738167;79969.60015199945;80282.59858700728;81654.77517837296;82541.58729206376;10787.6224332148;10851.039370629664;11023.338599684044;11037.944810275898;11077.944610277058;14839.554813355617;15067.773983390258;15074.773878391832;15076.623084422758;15112.95975043377;7533.284337987882;7601.19940029985;7691.192424795316;7702.614869256627;7777.377809775205;7096.325849044332;7111.644417779194;7149.463790215755;7373.373263272575;7411.740589079356;4563.885902852455;4583.518730533313;4586.541345865387;4668;4703.106409782199;1855.8886466812035;1879.4173806120145;1912.8660993730305;1919.2131226197191;1948.4544327588299;928.4429342394644;939.43633819709;940.2243149401771;981.7692842182081;985.1084768284713;17865.910670446825;17899.28402863897;18863.24547018104;18925.337613183474;20369.796302037088;931.2456909903;966.7824739433712;970.5292932927524;973.177664873181;985.1084768284713;10407;10741.462926853626;10742.516586753614;10768.407737574353;10790.136789056856;462662;467782;481554;481966;484943;84625.57687211524;87565.56217219001;94684;95009;95199;968.4673429613684;985.9852102218473;1019.3323373190572;1020.7907378987289;1025.3386565665105;16569.17154142264;16647.750283745994;17157.742633860253;17560.56098597545;17698.11509424498;41728.58271417368;42043.7897810509;42747;43042.35436468518;43683.56316436922;55747.72126139343;59294.40705592889;60434.39565604464;60874.391256088646;60905;8117.391195660231;8153;8222.671093156207;8471.407001509835;8489.278411335106;12009.699757506132;12521.874781252436;12700.30148341813;12705.491780328683;12776.74446511046;11038.779224415628;11205.103591712481;11305.604303849326;11329.433528323716;11351.545938162712;11188.888111118784;11219.158563107636;11232.66302010941;11246.831297530707;11299.152563557931;10927.781444371227;11313.830292545454;11352.94323528377;11482.712932176428;11651.53393864236;8175.754727358189;8281.668733250603;8322.833543329221;8379.95810020946;8614.44006139599;9714.417134971642;11225.270357426742;11445.828312575484;11630.185886987829;11700.765984680429 06:59:55 INFO - PROCESS | 30762 | |3;mootools.html;1359.8912087033027;1464.1434760665006;1502.6468779836737;1606.3253433557904;1732.4109802667099;7590;8384.538850363228;8737.301015918727;8761.38670293079;8779.956100219506;8636.524991125485;8822.206001459866;8829.690960816357;9003.45979241246;9023.639054437816;2293.5183611441616;2339.777721116491;2341.555104530142;2341.6838726771925;2346.753590872959;2301.942451438719;2351.0360752091647;2354.505553833697;2356.634721618152;2359.2922123362923;2336.1356298169703;2353.2940117964627;2376.774206450393;2378.95242095158;2385.1651921827397;2264.615015447378;2283.7031185945802;2288.6109361408517;2289.7366802817724;2317.4206448387904;2300.4823914619246;2305.089489651595;2306.573283942476;2307.3193407944696;2307.7576854430213;8904.332175086894;8971.596278167499;9027.232685221765;9034.14175653312;9036.141566551167;5423.538999185074;5580.497755202051;5582.972085139589;5584.134459158837;5589.80435684749;3472.791632502058;3485.3029394121277;3537.4163263061564;3546.521219635342;3547.4324108142832;1197.6526807225894;1201.957931472403;1206.6741979665442;1225.9080568957274;2180.193328468461;12660.556880509139;12986.480540778357;13019.934900325532;13043.08698391113;13068.215907045607;4689.343491911135;4713.387259656222;4846.29728689338;4963.255511673206;5046.545810877039;10913.399763012952;10922.508487118099;10947.83578246327;10958.56165753361;10995.450227488753;5429.294191755125;5436.510714035756;5442.020436321421;5443.564514838883;5444.265024221759;4318.805653745589;4380.4305440292555;4384.56154384559;4568.543145685405;4975.502449754996;4064.20747954152;4135.243530336814;4223.303154979455;4225.72532785368;4225.915481690349;1332.393760838816;1348.4336578636996;1359.6193065941552;1363.6659018540522;1374.3540535948089;840.6637345061902;980.9901900981041;987.6049580167846;994.4828689081637;1029.1663752360612;5962.761489540457;6022;6063.969680151571;6133.080037994337;6383.425491705676;459.6736317214748;460.2268189441703;463.2703492000113;1026.9537870795832;1032.2516175772505;4138.6482149017675;4256.106217694319;4326.178026175016;4352.064306174125;4369.710935274038;11087.556497740161;11454.713632159262;11479;11493.01181692766;11511.539538418538;11302.773944521228;11315.151363647594;11318.132508136065;11332.773344533063;11356.48895799691;7996.360291176692;8326.29226515753;8328.500289982621;8336.583170841433;8516.361272904556;6179.28938172116;6181.567290289637;6226.657533835682;6398.955597964966;6452.257990331172;10334.741631459274;10360.430176340373;10519.78960420772;10527.684169474927;10535.367877927349;10488.388712039023;10505.737356566147;10694.89305106939;10750.8387374191;10846.620368287073;7725.884111738441;7813.960930195312;7854.057513098464;7856.84286314282;7877.921220787948;8421.410501264852;8513.787155321166;8590.82818343642;8596.312295016509;8596.570171491276;7633.313001829862;7695;7703.075630924325;7817.648205830637;7953.443258972048;7409.37020353276;7525.962370188114;7551.660175292235;7569.621518923922;7754.806129846574;7039.296070392919;7170.928290717026;7171.748988785367;7187.640617969185;7229.638518074181;5277.947220527745;5302.178162384682;5352.892942141058;5420.647657902224;5550.888982220252;5239;5250.369955605352;5352.759125839269;5383.730813459233;5391.568674505952 06:59:55 INFO - PROCESS | 30762 | |4;prototype.html;328.9687479689429;335.72135127843893;338.0922223829019;343.1729531828294;344.9172198672318;5116.411612664545;5181.248718935752;5190.455002224764;5215.1655735082395;5223.947760522394;5088.821891233808;5091.8034261948505;5092.694438333702;5098.413682426522;5125.154349532332;3825.2731980923604;3986.5016872890887;3998.5201775786945;4017.4332010515923;4105.445764821756;4083.4895638045246;4091.774952377618;4092.570280120589;4098.897527561805;4113.670906327487;4051.918961620766;4062.7156099073077;4067.2882245607047;4072.572379900112;4073.775942323171;3835.5589107252745;3857.9228415431676;3974.5429275633237;4006.1386801837452;4053.7567745935044;3589.192431702872;3597.6402359763815;3598.2803439312243;3598.8200589970397;3619.6380361963857;5017.297578339036;5029.622778291606;5038.39539255288;5042;5092.872678183075;4563.657725670588;4630.699004564693;4650.395448591696;4665.020345727401;4681.5318468153255;5387.380451248117;5388.164834450667;5390.811321603765;5398.379186393576;5400.378956420022;3979.7413168144267;3981.542122655903;3984.9601503984877;4000.599940006005;4003.799810009517;5528.695921724304;5568.86077848053;5576.832695019156;5606.906653202627;5679.403662615448;4065.780265920271;4069.674426045909;4080.449139366207;4091.959080409217;4101.405296232029;4150.481189851269;4156.25187466259;4156.729812562174;4161.604647558538;4161.687873409506;4569.725816451024;4635.860924172281;4670.462896766848;4710.26990816424;4721.8347357842995;5366.812161574404;5401.513863752281;5409.891802163935;5410.269613602192;5420.864478388072;1406.606150277924;1430.542226487514;1432.1264028942337;1445.2340259662396;1445.4001589340305;871.901404230674;940.3652534539159;945.6122989574242;947.1759569174862;960.5437417226761;5029.723365214875;5119.283300337956;5192.378782883237;5309.628326017219;5309.8938021239355;5595.63628364155;5604.449975261246;5607.607467477319;5621.662700237999;5638.661680299113;5101.54605937306;5231.032259032091;5284.841454756363;5286.471352864683;5291.444398338196;2906.5640153977074;2932.1643331650375;2940.705929407085;2942.80871743336;2950.2181921790743;5680.77276908919;5701.800436984686;5702.51528620072;5705.372409035002;5705.5720820938595;5400.324959380077;5570.554355651539;5638.35158956717;5653.519450846724;5685.744141513642;5691.544676425793;5695.5443564514735;5699.715014249271;5733.369329373765;5777.942220577908;5356.544693701079;5568.443155684399;5588.776448941997;5604.8038318658655;5612.130119831432;5543.584231182596;5556.861078473071;5560.777568897199;5561.6641010774765;5565.248691426606;5768.826935191783;5810;5815.505682017076;5822.592418530662;5834.504067154339;3933.8671559487157;4041.9797901010306;4044.7168698190844;4071.7556946582113;4075.2257071156387;5583.581231407742;5585.385607583082;5593.608447408642;5596.188552659923;5604.113881351189;5438.673679579238;5440.6735595864375;5455.18172274162;5463;5469.288992430958;5205;5408.513233808976;5455.645383050248;5460.235567020541;5464.453554644663;5388.545092824994;5398.5951053671915;5401.839923644712;5402.75687594067;5409.4590540947165;5209.739513024258;5223.503767142115;5371.838844834661;5428.755705993319;5444.366689993066;5258.579313654975;5276.868078298074;5299.549538289289;5306.628536002443;5311.256424100707 06:59:55 INFO - PROCESS | 30762 | |5;yui.html;750.0886422996059;763.45794485915;792.9682812687493;794.9483283586567;832.9875051874221;15633.530994070168;16982.83017169828;17076.573085672866;17086.65826683467;17131.74302385465;15242.085474871488;15310.234488275597;15335.923320383383;15347.462838800644;15347.616309592266;654.2802916791538;663.6449499517759;771.7877583664509;774.6978678315476;793.6388943030908;784.1374488063142;790.2729488870253;797.2744802229972;797.9920200797976;798.409177208867;846.9788255293636;847.894013248344;848.0628905059913;848.1179573243819;848.3001523742906;685.0546246180289;695.1276148433683;841.0454134557291;842.3513894301353;842.9325653947669;588.7556663984441;590.6633219065135;603.8973374526341;604.1511676095049;607.0439058482863;15027.398904043825;15031.248437578077;15038.172900490468;15063.54809355721;15065.09609423438;13941.233232172226;13965.79051314231;14100.647483812883;14219.50231741884;14232.644183895382;12217.144799864012;12268.141230113895;12321.307689244653;12561.811572826415;12723.491060357575;4396.538363471821;4454.754988475633;4459;4466.843660471868;4476.261416866213;76784;77675.61162194153;77693.3383996962;82207.58896205541;83127.99999999939;11318.924702153283;11340.829887551694;11695.532178712756;11752.177347585757;11888.702782430508;21630.35108946734;21882.89058554697;21958.780412195993;21967.560648786934;22043.448913777283;7619.314261716361;7778.727744528915;7898;8112.675492980333;8440.915590844135;4468.575485328954;4471.709338893027;4560.794764235618;4645.790939407735;4661.417322834645;3581.4627805828814;3676.338259113332;3680.723945704083;3693.5567731872347;3702.444633304972;684.387473211473;686.5777546808777;707.1867352544615;710.1159056974101;731.6012773038707;565.1889538512248;589.1751547832982;678.3860606151441;704.5091571264372;728.6356821589205;9887.950560247153;10101.242406819518;10252.179825613934;10304.330218535772;10323;618.4125081172904;636.7866764633807;667.8330417395651;688.5111570784799;700.1458220970408;4768.809247630125;4959.776810043557;4986.227134794112;4993.50064993505;5002.549770520671;72021.63989180021;72313;96308;126673.36663316809;130756;61280.69359653263;89814;107343;107528;115842;59866.40133598696;70107.64946175237;74348;75170.24829751633;77412;9058.773530661787;9117.17945384892;9467.763305917408;9593.856092158763;9831.557579909064;51143.744281278356;52052.47947520476;52751;52798;53156.2026569594;40788.79605601953;58929;72488.63755681188;73016.26983730095;73301.26698732945;12288.569900053813;12384.690382740144;12522.436490357773;12915.418806153933;13090.60728178118;13000.609981700563;13404.195748255135;13699;13765.793513097111;13809.171449713049;13587.728245435233;13590.864091359355;13705.383257753225;13989.860101398855;14352.210628415538;13422.328883555978;13782.793258101337;13883.097598656055;13895.722085558435;14333.354999025278;12777.425015874494;13169.604911852659;13420.194788312732;13969.371378287799;13980.44078236859;10480.842787358044;10589.205809564159;10993.890061099286;11058.557657693602;11639.185257031926;11188.552457901593;11288.604898828502;11489.885101149215;11492.425378730863;11516.42417879086 06:59:55 INFO - PROCESS | 30762 | __end_tp_report 06:59:55 INFO - PROCESS | 30762 | __start_cc_report 06:59:55 INFO - PROCESS | 30762 | _x_x_mozilla_cycle_collect,1145 06:59:55 INFO - PROCESS | 30762 | __end_cc_report 06:59:55 INFO - PROCESS | 30762 | __startTimestamp1475071195930__endTimestamp 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | ------- Summary: start ------- 06:59:55 INFO - PROCESS | 30762 | Number of tests: 6 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#0] dojo.html Cycles:165 Average:5372.87 Median:5529.47 stddev:604.20 (10.9%) stddev-sans-first:578.26 06:59:55 INFO - PROCESS | 30762 | Values: 3063.9 3093.6 3094.2 3120.7 3150.5 5261.9 5314.2 5352.3 5418.7 5420.1 5397.7 5429.2 5430.2 5477.0 5507.6 4888.9 4907.0 4932.4 4942.2 5007.8 5032.0 5035.1 5035.6 5037.9 5042.9 4808.9 4815.5 4862.4 5016.2 5028.2 4874.5 4963.2 4966.0 4987.7 4988.3 4837.0 4860.7 4872.8 4890.5 4928.0 5425.4 5426.7 5428.6 5436.3 5437.9 5689.5 5693.7 5723.1 5736.0 5740.7 5773.9 5788.6 5800.8 5801.6 5850.1 5406.8 5409.6 5411.5 5413.5 5417.0 5790.3 5800.8 5861.0 5895.9 5938.9 5656.9 5693.8 5706.5 5707.9 5715.1 5802.1 5857.5 5858.1 5867.4 5944.5 5841.9 5854.1 5855.3 5857.2 5857.5 5649.0 5819.5 5853.4 5856.2 5864.1 4439.3 4445.2 4475.7 4477.0 4527.5 3959.1 3975.3 3976.1 4016.3 4017.7 5436.1 5479.7 5490.8 5496.9 5503.3 5705.5 5727.7 5738.7 5790.5 5794.0 5498.7 5501.9 5505.5 5531.9 5564.5 4910.4 4941.8 4944.4 4944.5 4996.4 5882.0 5918.5 5927.4 6036.3 6041.7 5773.3 5798.2 5808.0 5827.9 5828.1 5972.5 5984.2 5999.1 6006.2 6042.9 5737.4 5739.7 5752.4 5752.7 5769.5 5795.8 5820.3 5825.4 5825.6 5848.3 5437.3 5467.1 5510.6 5529.5 5554.1 5554.0 5554.9 5555.3 5559.2 5610.9 5440.5 5479.7 5487.0 5502.1 5557.9 5583.9 5604.0 5638.4 5652.8 5671.5 5523.2 5523.4 5544.1 5564.3 5581.9 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#1] ext.html Cycles:180 Average:59614.27 Median:42670.57 stddev:115968.85 (271.8%) stddev-sans-first:116209.39 06:59:55 INFO - PROCESS | 30762 | Values: 554.2 592.2 610.6 618.8 634.8 32349.4 42412.2 43426.6 43450.8 43538.6 44987.6 44997.0 45234.3 45243.0 45304.0 8821.0 8956.7 8958.9 8965.4 8989.9 8630.3 8745.2 8748.3 8752.9 8771.6 8757.2 8784.0 8808.0 8817.0 8817.8 8696.1 8737.3 8760.7 8764.0 8825.3 8552.7 8890.4 8901.6 8904.9 8909.7 42258.8 42535.1 42560.8 42667.4 42673.8 3406.1 3500.9 3592.8 3848.5 4029.3 31634.5 31856.2 31904.4 32507.5 33576.8 4363.5 4374.3 4434.1 4659.7 4670.9 315271.0 349893.0 350486.0 350832.0 351002.2 62336.7 63301.7 63382.4 63387.0 63419.7 64096.4 64463.4 64564.4 64972.4 64991.0 14969.6 15125.2 15175.5 15199.9 15206.7 11420.5 11515.0 11516.9 11522.2 11528.1 19026.6 19106.4 19194.0 19314.6 19550.2 6968.5 7475.5 7499.0 7576.7 7664.8 883.1 960.9 964.7 999.6 1008.7 30391.2 32196.0 33044.8 34693.7 34724.7 1020.4 1070.6 1093.7 1105.8 1138.4 15805.0 16467.6 16702.0 16746.2 16769.3 493551.0 497839.0 497948.0 498341.0 498653.0 50573.0 51000.0 51061.7 51076.7 51100.7 1192.4 1223.8 1241.2 1275.9 1324.4 27612.9 30125.8 31868.2 34144.5 34374.7 53214.5 53698.7 53935.5 54019.0 54028.0 454429.0 455966.0 460201.0 460212.0 460391.0 27994.3 28053.6 28565.9 28568.9 28582.4 43974.0 46638.3 47901.8 47947.8 47950.5 38582.0 39150.8 39818.6 40928.4 41204.6 39500.6 39547.2 40448.0 40509.2 41193.6 35512.1 35725.8 38032.2 40887.6 41015.6 30466.8 35404.5 36737.6 36892.3 42758.4 31655.8 31953.4 33533.2 33601.3 33691.7 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#2] jquery.html Cycles:180 Average:28088.54 Median:42395.39 stddev:78610.12 (185.4%) stddev-sans-first:78803.10 06:59:55 INFO - PROCESS | 30762 | Values: 378.1 380.9 388.6 395.3 414.5 13479.5 14179.5 15935.8 18876.4 18880.7 17397.2 18020.1 18111.4 18130.4 18249.4 5548.3 5788.3 5789.9 5802.2 5806.9 5509.5 5675.6 5754.6 5779.7 5870.5 5855.2 5857.1 5860.7 5866.5 5866.6 5680.3 5815.0 5845.1 5857.6 5858.6 5508.0 5679.1 5681.6 5682.3 5698.5 13309.7 13410.9 13539.9 13543.3 13559.0 2291.8 2497.2 2698.5 2704.3 2714.5 9450.8 9463.0 9720.6 10085.8 10335.5 1788.5 1804.3 1877.4 1879.1 1897.2 73818.3 79969.6 80282.6 81654.8 82541.6 10787.6 10851.0 11023.3 11037.9 11077.9 14839.6 15067.8 15074.8 15076.6 15113.0 7533.3 7601.2 7691.2 7702.6 7777.4 7096.3 7111.6 7149.5 7373.4 7411.7 4563.9 4583.5 4586.5 4668.0 4703.1 1855.9 1879.4 1912.9 1919.2 1948.5 928.4 939.4 940.2 981.8 985.1 17865.9 17899.3 18863.2 18925.3 20369.8 931.2 966.8 970.5 973.2 985.1 10407.0 10741.5 10742.5 10768.4 10790.1 462662.0 467782.0 481554.0 481966.0 484943.0 84625.6 87565.6 94684.0 95009.0 95199.0 968.5 986.0 1019.3 1020.8 1025.3 16569.2 16647.8 17157.7 17560.6 17698.1 41728.6 42043.8 42747.0 43042.4 43683.6 55747.7 59294.4 60434.4 60874.4 60905.0 8117.4 8153.0 8222.7 8471.4 8489.3 12009.7 12521.9 12700.3 12705.5 12776.7 11038.8 11205.1 11305.6 11329.4 11351.5 11188.9 11219.2 11232.7 11246.8 11299.2 10927.8 11313.8 11352.9 11482.7 11651.5 8175.8 8281.7 8322.8 8380.0 8614.4 9714.4 11225.3 11445.8 11630.2 11700.8 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#3] mootools.html Cycles:180 Average:5951.30 Median:4476.55 stddev:3420.36 (76.4%) stddev-sans-first:3412.55 06:59:55 INFO - PROCESS | 30762 | Values: 1359.9 1464.1 1502.6 1606.3 1732.4 7590.0 8384.5 8737.3 8761.4 8780.0 8636.5 8822.2 8829.7 9003.5 9023.6 2293.5 2339.8 2341.6 2341.7 2346.8 2301.9 2351.0 2354.5 2356.6 2359.3 2336.1 2353.3 2376.8 2379.0 2385.2 2264.6 2283.7 2288.6 2289.7 2317.4 2300.5 2305.1 2306.6 2307.3 2307.8 8904.3 8971.6 9027.2 9034.1 9036.1 5423.5 5580.5 5583.0 5584.1 5589.8 3472.8 3485.3 3537.4 3546.5 3547.4 1197.7 1202.0 1206.7 1225.9 2180.2 12660.6 12986.5 13019.9 13043.1 13068.2 4689.3 4713.4 4846.3 4963.3 5046.5 10913.4 10922.5 10947.8 10958.6 10995.5 5429.3 5436.5 5442.0 5443.6 5444.3 4318.8 4380.4 4384.6 4568.5 4975.5 4064.2 4135.2 4223.3 4225.7 4225.9 1332.4 1348.4 1359.6 1363.7 1374.4 840.7 981.0 987.6 994.5 1029.2 5962.8 6022.0 6064.0 6133.1 6383.4 459.7 460.2 463.3 1027.0 1032.3 4138.6 4256.1 4326.2 4352.1 4369.7 11087.6 11454.7 11479.0 11493.0 11511.5 11302.8 11315.2 11318.1 11332.8 11356.5 7996.4 8326.3 8328.5 8336.6 8516.4 6179.3 6181.6 6226.7 6399.0 6452.3 10334.7 10360.4 10519.8 10527.7 10535.4 10488.4 10505.7 10694.9 10750.8 10846.6 7725.9 7814.0 7854.1 7856.8 7877.9 8421.4 8513.8 8590.8 8596.3 8596.6 7633.3 7695.0 7703.1 7817.6 7953.4 7409.4 7526.0 7551.7 7569.6 7754.8 7039.3 7170.9 7171.7 7187.6 7229.6 5277.9 5302.2 5352.9 5420.6 5550.9 5239.0 5250.4 5352.8 5383.7 5391.6 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#4] prototype.html Cycles:180 Average:4584.71 Median:5223.73 stddev:1332.51 (25.5%) stddev-sans-first:1297.39 06:59:55 INFO - PROCESS | 30762 | Values: 329.0 335.7 338.1 343.2 344.9 5116.4 5181.2 5190.5 5215.2 5223.9 5088.8 5091.8 5092.7 5098.4 5125.2 3825.3 3986.5 3998.5 4017.4 4105.4 4083.5 4091.8 4092.6 4098.9 4113.7 4051.9 4062.7 4067.3 4072.6 4073.8 3835.6 3857.9 3974.5 4006.1 4053.8 3589.2 3597.6 3598.3 3598.8 3619.6 5017.3 5029.6 5038.4 5042.0 5092.9 4563.7 4630.7 4650.4 4665.0 4681.5 5387.4 5388.2 5390.8 5398.4 5400.4 3979.7 3981.5 3985.0 4000.6 4003.8 5528.7 5568.9 5576.8 5606.9 5679.4 4065.8 4069.7 4080.4 4092.0 4101.4 4150.5 4156.3 4156.7 4161.6 4161.7 4569.7 4635.9 4670.5 4710.3 4721.8 5366.8 5401.5 5409.9 5410.3 5420.9 1406.6 1430.5 1432.1 1445.2 1445.4 871.9 940.4 945.6 947.2 960.5 5029.7 5119.3 5192.4 5309.6 5309.9 5595.6 5604.4 5607.6 5621.7 5638.7 5101.5 5231.0 5284.8 5286.5 5291.4 2906.6 2932.2 2940.7 2942.8 2950.2 5680.8 5701.8 5702.5 5705.4 5705.6 5400.3 5570.6 5638.4 5653.5 5685.7 5691.5 5695.5 5699.7 5733.4 5777.9 5356.5 5568.4 5588.8 5604.8 5612.1 5543.6 5556.9 5560.8 5561.7 5565.2 5768.8 5810.0 5815.5 5822.6 5834.5 3933.9 4042.0 4044.7 4071.8 4075.2 5583.6 5585.4 5593.6 5596.2 5604.1 5438.7 5440.7 5455.2 5463.0 5469.3 5205.0 5408.5 5455.6 5460.2 5464.5 5388.5 5398.6 5401.8 5402.8 5409.5 5209.7 5223.5 5371.8 5428.8 5444.4 5258.6 5276.9 5299.5 5306.6 5311.3 06:59:55 INFO - PROCESS | 30762 | 06:59:55 INFO - PROCESS | 30762 | [#5] yui.html Cycles:180 Average:19764.56 Median:4473.99 stddev:27866.91 (622.9%) stddev-sans-first:27908.50 06:59:55 INFO - PROCESS | 30762 | Values: 750.1 763.5 793.0 794.9 833.0 15633.5 16982.8 17076.6 17086.7 17131.7 15242.1 15310.2 15335.9 15347.5 15347.6 654.3 663.6 771.8 774.7 793.6 784.1 790.3 797.3 798.0 798.4 847.0 847.9 848.1 848.1 848.3 685.1 695.1 841.0 842.4 842.9 588.8 590.7 603.9 604.2 607.0 15027.4 15031.2 15038.2 15063.5 15065.1 13941.2 13965.8 14100.6 14219.5 14232.6 12217.1 12268.1 12321.3 12561.8 12723.5 4396.5 4454.8 4459.0 4466.8 4476.3 76784.0 77675.6 77693.3 82207.6 83128.0 11318.9 11340.8 11695.5 11752.2 11888.7 21630.4 21882.9 21958.8 21967.6 22043.4 7619.3 7778.7 7898.0 8112.7 8440.9 4468.6 4471.7 4560.8 4645.8 4661.4 3581.5 3676.3 3680.7 3693.6 3702.4 684.4 686.6 707.2 710.1 731.6 565.2 589.2 678.4 704.5 728.6 9888.0 10101.2 10252.2 10304.3 10323.0 618.4 636.8 667.8 688.5 700.1 4768.8 4959.8 4986.2 4993.5 5002.5 72021.6 72313.0 96308.0 126673.4 130756.0 61280.7 89814.0 107343.0 107528.0 115842.0 59866.4 70107.6 74348.0 75170.2 77412.0 9058.8 9117.2 9467.8 9593.9 9831.6 51143.7 52052.5 52751.0 52798.0 53156.2 40788.8 58929.0 72488.6 73016.3 73301.3 12288.6 12384.7 12522.4 12915.4 13090.6 13000.6 13404.2 13699.0 13765.8 13809.2 13587.7 13590.9 13705.4 13989.9 14352.2 13422.3 13782.8 13883.1 13895.7 14333.4 12777.4 13169.6 13420.2 13969.4 13980.4 10480.8 10589.2 10993.9 11058.6 11639.2 11188.6 11288.6 11489.9 11492.4 11516.4 06:59:55 INFO - PROCESS | 30762 | -------- Summary: end -------- 06:59:55 INFO - PROCESS | 30762 | 06:59:56 INFO - TEST-INFO | 30762: exit 0 06:59:56 INFO - TEST-OK | dromaeo_css | took 1115956ms 06:59:56 INFO - TEST-START | kraken 06:59:56 INFO - operating with platform_type : linux_ 06:59:56 INFO - Initialising browser for kraken test... 06:59:56 INFO - TEST-INFO | started process 31063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqF3z0h/profile http://localhost:55220/getInfo.html) 07:00:00 INFO - PROCESS | 31063 | __metrics Screen width/height:1600/1200 07:00:00 INFO - PROCESS | 31063 | colorDepth:24 07:00:00 INFO - PROCESS | 31063 | Browser inner width/height: 1024/697 07:00:00 INFO - PROCESS | 31063 | __metrics 07:00:01 INFO - PROCESS | 31063 | 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" 07:00:01 INFO - PROCESS | 31063 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:02 INFO - PROCESS | 31063 | console.error: PushService: 07:00:02 INFO - PROCESS | 31063 | stateChangeProcessEnqueue: Error transitioning state 07:00:02 INFO - PROCESS | 31063 | UnknownError 07:00:02 INFO - TEST-INFO | 31063: exit 0 07:00:02 INFO - Browser initialized. 07:00:02 INFO - Running cycle 1/1 for kraken test... 07:00:02 INFO - TEST-INFO | started process 31147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqF3z0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:14 INFO - PROCESS | 31147 | RSS: Main: 174030848 07:00:14 INFO - PROCESS | 31147 | 07:00:17 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55220/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:18 INFO - PROCESS | 31147 | RSS: Main: 232960000 07:00:18 INFO - PROCESS | 31147 | 07:00:20 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55220/tests/kraken/driver.html?testName=audio-dft) 07:00:21 INFO - PROCESS | 31147 | RSS: Main: 217317376 07:00:21 INFO - PROCESS | 31147 | 07:00:24 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55220/tests/kraken/driver.html?testName=audio-fft) 07:00:25 INFO - PROCESS | 31147 | RSS: Main: 298881024 07:00:25 INFO - PROCESS | 31147 | 07:00:27 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55220/tests/kraken/driver.html?testName=audio-oscillator) 07:00:27 INFO - PROCESS | 31147 | RSS: Main: 208748544 07:00:27 INFO - PROCESS | 31147 | 07:00:30 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:30 INFO - PROCESS | 31147 | RSS: Main: 212865024 07:00:30 INFO - PROCESS | 31147 | 07:00:33 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55220/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:34 INFO - PROCESS | 31147 | RSS: Main: 249495552 07:00:34 INFO - PROCESS | 31147 | 07:00:37 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55220/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:38 INFO - PROCESS | 31147 | RSS: Main: 247947264 07:00:38 INFO - PROCESS | 31147 | 07:00:40 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55220/tests/kraken/driver.html?testName=json-parse-financial) 07:00:41 INFO - PROCESS | 31147 | RSS: Main: 248451072 07:00:41 INFO - PROCESS | 31147 | 07:00:43 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:43 INFO - PROCESS | 31147 | RSS: Main: 210436096 07:00:43 INFO - PROCESS | 31147 | 07:00:45 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:00:46 INFO - PROCESS | 31147 | RSS: Main: 217681920 07:00:46 INFO - PROCESS | 31147 | 07:00:48 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:48 INFO - PROCESS | 31147 | RSS: Main: 222105600 07:00:48 INFO - PROCESS | 31147 | 07:00:51 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:51 INFO - PROCESS | 31147 | RSS: Main: 223805440 07:00:51 INFO - PROCESS | 31147 | 07:00:54 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:00:55 INFO - PROCESS | 31147 | RSS: Main: 222121984 07:00:55 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | Cycle 1(1): loaded http://localhost:55220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55220/tests/kraken/driver.html?testName=ai-astar) 07:00:57 INFO - PROCESS | 31147 | RSS: Main: 272949248 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | __start_tp_report 07:00:57 INFO - PROCESS | 31147 | _x_x_mozilla_page_load 07:00:57 INFO - PROCESS | 31147 | _x_x_mozilla_page_load_details 07:00:57 INFO - PROCESS | 31147 | |i|pagename|runs| 07:00:57 INFO - PROCESS | 31147 | |0;ai-astar;107;110;111;110;111;110;111;110;110;111 07:00:57 INFO - PROCESS | 31147 | |1;audio-beat-detection;146;119;118;174;120;120;124;118;162;117 07:00:57 INFO - PROCESS | 31147 | |2;audio-dft;162;162;162;160;160;161;163;163;161;163 07:00:57 INFO - PROCESS | 31147 | |3;audio-fft;75;75;77;102;76;76;76;76;107;75 07:00:57 INFO - PROCESS | 31147 | |4;audio-oscillator;82;81;117;80;82;80;107;81;81;113 07:00:57 INFO - PROCESS | 31147 | |5;imaging-gaussian-blur;116;116;116;116;117;117;116;117;118;116 07:00:57 INFO - PROCESS | 31147 | |6;imaging-darkroom;147;148;147;147;147;147;146;146;146;146 07:00:57 INFO - PROCESS | 31147 | |7;imaging-desaturate;94;96;96;96;96;96;95;94;95;95 07:00:57 INFO - PROCESS | 31147 | |8;json-parse-financial;52;52;50;50;52;52;53;53;55;55 07:00:57 INFO - PROCESS | 31147 | |9;json-stringify-tinderbox;60;60;60;61;60;59;60;60;60;61 07:00:57 INFO - PROCESS | 31147 | |10;stanford-crypto-aes;79;78;83;79;80;80;79;87;82;84 07:00:57 INFO - PROCESS | 31147 | |11;stanford-crypto-ccm;124;133;122;121;130;126;123;124;165;131 07:00:57 INFO - PROCESS | 31147 | |12;stanford-crypto-pbkdf2;173;164;166;171;164;164;172;167;163;168 07:00:57 INFO - PROCESS | 31147 | |13;stanford-crypto-sha256-iterative;66;65;66;65;64;64;68;64;65;65 07:00:57 INFO - PROCESS | 31147 | __end_tp_report 07:00:57 INFO - PROCESS | 31147 | __start_cc_report 07:00:57 INFO - PROCESS | 31147 | _x_x_mozilla_cycle_collect,1692 07:00:57 INFO - PROCESS | 31147 | __end_cc_report 07:00:57 INFO - PROCESS | 31147 | __startTimestamp1475071257279__endTimestamp 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | ------- Summary: start ------- 07:00:57 INFO - PROCESS | 31147 | Number of tests: 14 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.20 (1.1%) stddev-sans-first:0.53 07:00:57 INFO - PROCESS | 31147 | Values: 107.0 110.0 111.0 110.0 111.0 110.0 111.0 110.0 110.0 111.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:122.00 stddev:21.08 (17.3%) stddev-sans-first:21.72 07:00:57 INFO - PROCESS | 31147 | Values: 146.0 119.0 118.0 174.0 120.0 120.0 124.0 118.0 162.0 117.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 07:00:57 INFO - PROCESS | 31147 | Values: 162.0 162.0 162.0 160.0 160.0 161.0 163.0 163.0 161.0 163.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.20 (16.0%) stddev-sans-first:12.71 07:00:57 INFO - PROCESS | 31147 | Values: 75.0 75.0 77.0 102.0 76.0 76.0 76.0 76.0 107.0 75.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:15.33 (18.9%) stddev-sans-first:15.96 07:00:57 INFO - PROCESS | 31147 | Values: 82.0 81.0 117.0 80.0 82.0 80.0 107.0 81.0 81.0 113.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:00:57 INFO - PROCESS | 31147 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 118.0 116.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:00:57 INFO - PROCESS | 31147 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 07:00:57 INFO - PROCESS | 31147 | Values: 94.0 96.0 96.0 96.0 96.0 96.0 95.0 94.0 95.0 95.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.71 (3.3%) stddev-sans-first:1.81 07:00:57 INFO - PROCESS | 31147 | Values: 52.0 52.0 50.0 50.0 52.0 52.0 53.0 53.0 55.0 55.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:00:57 INFO - PROCESS | 31147 | Values: 60.0 60.0 60.0 61.0 60.0 59.0 60.0 60.0 60.0 61.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.85 (3.5%) stddev-sans-first:2.92 07:00:57 INFO - PROCESS | 31147 | Values: 79.0 78.0 83.0 79.0 80.0 80.0 79.0 87.0 82.0 84.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:128.00 stddev:12.98 (10.1%) stddev-sans-first:13.59 07:00:57 INFO - PROCESS | 31147 | Values: 124.0 133.0 122.0 121.0 130.0 126.0 123.0 124.0 165.0 131.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:3.68 (2.2%) stddev-sans-first:3.24 07:00:57 INFO - PROCESS | 31147 | Values: 173.0 164.0 166.0 171.0 164.0 164.0 172.0 167.0 163.0 168.0 07:00:57 INFO - PROCESS | 31147 | 07:00:57 INFO - PROCESS | 31147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 07:00:57 INFO - PROCESS | 31147 | Values: 66.0 65.0 66.0 65.0 64.0 64.0 68.0 64.0 65.0 65.0 07:00:57 INFO - PROCESS | 31147 | -------- Summary: end -------- 07:00:57 INFO - PROCESS | 31147 | 07:00:58 INFO - TEST-INFO | 31147: exit 0 07:00:58 INFO - TEST-OK | kraken | took 61665ms 07:00:58 INFO - SUITE-END | took 1177s 07:00:58 INFO - Completed test suite (00:19:38) 07:00:58 INFO - javascript benchmark 07:00:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.9387212255756, 3093.613298337708, 3094.1645755645977, 3120.734737547308, 3150.54317124017, 5261.86845328866, 5314.202869569566, 5352.30420045394, 5418.674879507233, 5420.1327787554, 5397.676139431637, 5429.158480435539, 5430.212619170218, 5477.0, 5507.642003269784, 4888.902221955576, 4907.018596280758, 4932.432770231433, 4942.184539550988, 5007.799688012475, 5032.0, 5035.093683137034, 5035.597152227813, 5037.874053148664, 5042.873928151807, 4808.927866082012, 4815.518448155191, 4862.36789217403, 5016.247562865563, 5028.245763135541, 4874.53691899269, 4963.1810751226, 4966.031623833354, 4987.650864439491, 4988.276699878534, 4836.975815120902, 4860.659753817235, 4872.756362181876, 4890.486498917598, 4927.950720492785, 5425.37608175061, 5426.701531415771, 5428.647137936022, 5436.293281873371, 5437.891242175174, 5689.516391106761, 5693.686847223401, 5723.112917497794, 5736.0, 5740.655560666331, 5773.88452230953, 5788.594798364116, 5800.8259752207505, 5801.593888427812, 5850.122481627747, 5406.783728650849, 5409.648372855751, 5411.5129638331955, 5413.485718856702, 5416.972915135439, 5790.276215473066, 5800.767969281266, 5861.032929566573, 5895.911561326584, 5938.851528711817, 5656.943430565641, 5693.772249109989, 5706.457886500776, 5707.914381284284, 5715.114157305624, 5802.1296805479515, 5857.502112320415, 5858.091995740667, 5867.413258674099, 5944.464998150187, 5841.853953651193, 5854.121881717776, 5855.3266374367495, 5857.238558987305, 5857.47282744555, 5648.971755141198, 5819.505342045889, 5853.443922827325, 5856.238688970407, 5864.120381942657, 4439.289713645801, 4445.244308467568, 4475.686701930834, 4476.955230447719, 4527.501974782771, 3959.109200429938, 3975.284448799186, 3976.1451287973223, 4016.3373043448087, 4017.6986725995666, 5436.10304299794, 5479.726013699299, 5490.752916118784, 5496.890062198733, 5503.284573005483, 5705.4579814917515, 5727.6849773262875, 5738.655680659173, 5790.478856902899, 5793.971030144822, 5498.725063746797, 5501.9174712379345, 5505.532029777433, 5531.889362212733, 5564.4991950724625, 4910.386201724785, 4941.802327906916, 4944.406671199479, 4944.522675295375, 4996.375453068366, 5881.9705901470215, 5918.526517878646, 5927.436893495111, 6036.3360030396625, 6041.667708276087, 5773.3072031356505, 5798.246227990334, 5807.970960145172, 5827.912581311199, 5828.0966450200285, 5972.522198224045, 5984.16221728967, 5999.070144127667, 6006.219191505076, 6042.879142417215, 5737.368889422077, 5739.655620662774, 5752.424757524214, 5752.6836024019085, 5769.451902069297, 5795.7539129087445, 5820.330661973758, 5825.446582574648, 5825.59220854553, 5848.327442344014, 5437.293151890229, 5467.125259958388, 5510.559155267649, 5529.474699903502, 5554.055810512142, 5553.972230138824, 5554.888902222014, 5555.30558680165, 5559.193916881949, 5610.943890561042, 5440.510354068153, 5479.726013699219, 5487.0, 5502.0921547944145, 5557.888842223214, 5583.860403489945, 5603.971980140073, 5638.37977822431, 5652.7738890443925, 5671.517920976763, 5523.1991361253195, 5523.392426833126, 5544.085225937675, 5564.276644036249, 5581.944180558143], "value": 5332.159248034264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1780679831277, 592.2241863159262, 610.5512448350462, 618.7648693496468, 634.7968650031992, 32349.441561428255, 42412.15175696488, 43426.56573434265, 43450.782746086225, 43538.56461435385, 44987.550124498746, 44997.0, 45234.321485177665, 45243.0, 45304.0, 8820.955895220532, 8956.686515971942, 8958.86561701575, 8965.372423930296, 8989.910100899006, 8630.309575233998, 8745.169208925174, 8748.25639820616, 8752.862127923392, 8771.649134034631, 8757.211850933414, 8784.0, 8807.95596022019, 8816.955915220447, 8817.779555511099, 8696.086910874363, 8737.257333126692, 8760.737177884674, 8764.0, 8825.338099642488, 8552.743417697478, 8890.377673562853, 8901.554922253861, 8904.910950890539, 8909.688160914402, 42258.78870605627, 42535.1492970142, 42560.78719606382, 42667.35998960018, 42673.78663106664, 3406.148462884279, 3500.912477188065, 3592.8203589820405, 3848.4804551385487, 4029.294873397173, 31634.525482117788, 31856.20359491008, 31904.361912761615, 32507.512387314207, 33576.83211583951, 4363.47638283408, 4374.300111982067, 4434.11317736454, 4659.697119687244, 4670.859874203779, 315271.0, 349893.0, 350486.0, 350832.0, 351002.244988776, 62336.68831655903, 63301.68349158225, 63382.366176337644, 63387.0, 63419.68290158612, 64096.35903640997, 64463.355366446674, 64564.35435645677, 64972.35027649758, 64991.0, 14969.550913472613, 15125.243737813065, 15175.544733658007, 15199.924000379928, 15206.695866082617, 11420.486078126338, 11515.0, 11516.884831151581, 11522.193446458836, 11528.135389845795, 19026.61946761057, 19106.426807195807, 19194.0, 19314.613707726046, 19550.217991280475, 6968.512204145661, 7475.514091584029, 7499.0, 7576.7348142814735, 7664.80837979055, 883.1212943121507, 960.8668755363083, 964.6961207219704, 999.6001599360314, 1008.6721815410021, 30391.240218994702, 32196.0, 33044.83477582597, 34693.653063469545, 34724.65275347214, 1020.403064207447, 1070.6306324318255, 1093.748437859281, 1105.8175401058895, 1138.3568283919558, 15805.0, 16467.58831029234, 16702.0, 16746.162691865356, 16769.32922683079, 493551.0, 497839.0, 497948.0, 498341.0, 498653.0, 50573.0, 51000.0, 51061.744691276304, 51076.74461627742, 51100.74449627728, 1192.4335940428227, 1223.7736018836545, 1241.2118304876287, 1275.929823859678, 1324.4238756140917, 27612.861935690195, 30125.849370753007, 31868.203294917814, 34144.48783268303, 34374.65625343715, 53214.4678553225, 53698.73150634222, 53935.46064539461, 54019.0, 54028.0, 454429.0, 455966.0, 460201.0, 460212.0, 460391.0, 27994.300142496602, 28053.57919631248, 28565.857170714015, 28568.85715571409, 28582.428351432438, 43974.0, 46638.30042549297, 47901.76049119732, 47947.76026119847, 47950.520494794604, 38582.0, 39150.80424597859, 39818.60181398149, 40928.38607420831, 41204.58795412127, 39500.604993950845, 39547.2090558193, 40448.0, 40509.189816202925, 41193.58806412017, 35512.112197195274, 35725.821370892976, 38032.23935521219, 40887.59112408838, 41015.589844101174, 30466.84766576153, 35404.46893296551, 36737.632623673424, 36892.26215475729, 42758.358624620036, 31655.84172079125, 31953.360932781678, 33533.16167095842, 33601.327973440886, 33691.66308336984], "value": 19969.84019145077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.05863400133677, 380.87621523005015, 388.578392444198, 395.33780916964076, 414.4756882543583, 13479.460821567138, 14179.503717369895, 15935.76096358554, 18876.433706988777, 18880.716789248174, 17397.217125229363, 18020.098995050226, 18111.366102186425, 18130.3654372097, 18249.36127235547, 5548.250986116883, 5788.305403351604, 5789.942100579004, 5802.245708057946, 5806.912896306559, 5509.47659972304, 5675.602707810434, 5754.597178197528, 5779.653220806765, 5870.501007414375, 5855.151003104547, 5857.121431785245, 5860.736266868002, 5866.5306775458075, 5866.560007999396, 5680.289963754531, 5815.040518314473, 5845.09401042839, 5857.619254748471, 5858.619189752652, 5507.972460137674, 5679.062954612526, 5681.602287839853, 5682.261306030189, 5698.487136157766, 13309.667258318523, 13410.86589134106, 13539.932300338534, 13543.255120968342, 13559.0, 2291.8281128915232, 2497.2008957133726, 2698.541247987847, 2704.2506038496817, 2714.5113879501682, 9450.810983780355, 9463.0, 9720.562574684156, 10085.798284034277, 10335.483225838752, 1788.4545213709814, 1804.3323970131135, 1877.3804644467293, 1879.1074239736015, 1897.1936926806052, 73818.26181738167, 79969.60015199945, 80282.59858700728, 81654.77517837296, 82541.58729206376, 10787.6224332148, 10851.039370629664, 11023.338599684044, 11037.944810275898, 11077.944610277058, 14839.554813355617, 15067.773983390258, 15074.773878391832, 15076.623084422758, 15112.95975043377, 7533.284337987882, 7601.19940029985, 7691.192424795316, 7702.614869256627, 7777.377809775205, 7096.325849044332, 7111.644417779194, 7149.463790215755, 7373.373263272575, 7411.740589079356, 4563.885902852455, 4583.518730533313, 4586.541345865387, 4668.0, 4703.106409782199, 1855.8886466812035, 1879.4173806120145, 1912.8660993730305, 1919.2131226197191, 1948.4544327588299, 928.4429342394644, 939.43633819709, 940.2243149401771, 981.7692842182081, 985.1084768284713, 17865.910670446825, 17899.28402863897, 18863.24547018104, 18925.337613183474, 20369.796302037088, 931.2456909903, 966.7824739433712, 970.5292932927524, 973.177664873181, 985.1084768284713, 10407.0, 10741.462926853626, 10742.516586753614, 10768.407737574353, 10790.136789056856, 462662.0, 467782.0, 481554.0, 481966.0, 484943.0, 84625.57687211524, 87565.56217219001, 94684.0, 95009.0, 95199.0, 968.4673429613684, 985.9852102218473, 1019.3323373190572, 1020.7907378987289, 1025.3386565665105, 16569.17154142264, 16647.750283745994, 17157.742633860253, 17560.56098597545, 17698.11509424498, 41728.58271417368, 42043.7897810509, 42747.0, 43042.35436468518, 43683.56316436922, 55747.72126139343, 59294.40705592889, 60434.39565604464, 60874.391256088646, 60905.0, 8117.391195660231, 8153.0, 8222.671093156207, 8471.407001509835, 8489.278411335106, 12009.699757506132, 12521.874781252436, 12700.30148341813, 12705.491780328683, 12776.74446511046, 11038.779224415628, 11205.103591712481, 11305.604303849326, 11329.433528323716, 11351.545938162712, 11188.888111118784, 11219.158563107636, 11232.66302010941, 11246.831297530707, 11299.152563557931, 10927.781444371227, 11313.830292545454, 11352.94323528377, 11482.712932176428, 11651.53393864236, 8175.754727358189, 8281.668733250603, 8322.833543329221, 8379.95810020946, 8614.44006139599, 9714.417134971642, 11225.270357426742, 11445.828312575484, 11630.185886987829, 11700.765984680429], "value": 8887.31154399256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.8912087033027, 1464.1434760665006, 1502.6468779836737, 1606.3253433557904, 1732.4109802667099, 7590.0, 8384.538850363228, 8737.301015918727, 8761.38670293079, 8779.956100219506, 8636.524991125485, 8822.206001459866, 8829.690960816357, 9003.45979241246, 9023.639054437816, 2293.5183611441616, 2339.777721116491, 2341.555104530142, 2341.6838726771925, 2346.753590872959, 2301.942451438719, 2351.0360752091647, 2354.505553833697, 2356.634721618152, 2359.2922123362923, 2336.1356298169703, 2353.2940117964627, 2376.774206450393, 2378.95242095158, 2385.1651921827397, 2264.615015447378, 2283.7031185945802, 2288.6109361408517, 2289.7366802817724, 2317.4206448387904, 2300.4823914619246, 2305.089489651595, 2306.573283942476, 2307.3193407944696, 2307.7576854430213, 8904.332175086894, 8971.596278167499, 9027.232685221765, 9034.14175653312, 9036.141566551167, 5423.538999185074, 5580.497755202051, 5582.972085139589, 5584.134459158837, 5589.80435684749, 3472.791632502058, 3485.3029394121277, 3537.4163263061564, 3546.521219635342, 3547.4324108142832, 1197.6526807225894, 1201.957931472403, 1206.6741979665442, 1225.9080568957274, 2180.193328468461, 12660.556880509139, 12986.480540778357, 13019.934900325532, 13043.08698391113, 13068.215907045607, 4689.343491911135, 4713.387259656222, 4846.29728689338, 4963.255511673206, 5046.545810877039, 10913.399763012952, 10922.508487118099, 10947.83578246327, 10958.56165753361, 10995.450227488753, 5429.294191755125, 5436.510714035756, 5442.020436321421, 5443.564514838883, 5444.265024221759, 4318.805653745589, 4380.4305440292555, 4384.56154384559, 4568.543145685405, 4975.502449754996, 4064.20747954152, 4135.243530336814, 4223.303154979455, 4225.72532785368, 4225.915481690349, 1332.393760838816, 1348.4336578636996, 1359.6193065941552, 1363.6659018540522, 1374.3540535948089, 840.6637345061902, 980.9901900981041, 987.6049580167846, 994.4828689081637, 1029.1663752360612, 5962.761489540457, 6022.0, 6063.969680151571, 6133.080037994337, 6383.425491705676, 459.6736317214748, 460.2268189441703, 463.2703492000113, 1026.9537870795832, 1032.2516175772505, 4138.6482149017675, 4256.106217694319, 4326.178026175016, 4352.064306174125, 4369.710935274038, 11087.556497740161, 11454.713632159262, 11479.0, 11493.01181692766, 11511.539538418538, 11302.773944521228, 11315.151363647594, 11318.132508136065, 11332.773344533063, 11356.48895799691, 7996.360291176692, 8326.29226515753, 8328.500289982621, 8336.583170841433, 8516.361272904556, 6179.28938172116, 6181.567290289637, 6226.657533835682, 6398.955597964966, 6452.257990331172, 10334.741631459274, 10360.430176340373, 10519.78960420772, 10527.684169474927, 10535.367877927349, 10488.388712039023, 10505.737356566147, 10694.89305106939, 10750.8387374191, 10846.620368287073, 7725.884111738441, 7813.960930195312, 7854.057513098464, 7856.84286314282, 7877.921220787948, 8421.410501264852, 8513.787155321166, 8590.82818343642, 8596.312295016509, 8596.570171491276, 7633.313001829862, 7695.0, 7703.075630924325, 7817.648205830637, 7953.443258972048, 7409.37020353276, 7525.962370188114, 7551.660175292235, 7569.621518923922, 7754.806129846574, 7039.296070392919, 7170.928290717026, 7171.748988785367, 7187.640617969185, 7229.638518074181, 5277.947220527745, 5302.178162384682, 5352.892942141058, 5420.647657902224, 5550.888982220252, 5239.0, 5250.369955605352, 5352.759125839269, 5383.730813459233, 5391.568674505952], "value": 4729.125719170833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9687479689429, 335.72135127843893, 338.0922223829019, 343.1729531828294, 344.9172198672318, 5116.411612664545, 5181.248718935752, 5190.455002224764, 5215.1655735082395, 5223.947760522394, 5088.821891233808, 5091.8034261948505, 5092.694438333702, 5098.413682426522, 5125.154349532332, 3825.2731980923604, 3986.5016872890887, 3998.5201775786945, 4017.4332010515923, 4105.445764821756, 4083.4895638045246, 4091.774952377618, 4092.570280120589, 4098.897527561805, 4113.670906327487, 4051.918961620766, 4062.7156099073077, 4067.2882245607047, 4072.572379900112, 4073.775942323171, 3835.5589107252745, 3857.9228415431676, 3974.5429275633237, 4006.1386801837452, 4053.7567745935044, 3589.192431702872, 3597.6402359763815, 3598.2803439312243, 3598.8200589970397, 3619.6380361963857, 5017.297578339036, 5029.622778291606, 5038.39539255288, 5042.0, 5092.872678183075, 4563.657725670588, 4630.699004564693, 4650.395448591696, 4665.020345727401, 4681.5318468153255, 5387.380451248117, 5388.164834450667, 5390.811321603765, 5398.379186393576, 5400.378956420022, 3979.7413168144267, 3981.542122655903, 3984.9601503984877, 4000.599940006005, 4003.799810009517, 5528.695921724304, 5568.86077848053, 5576.832695019156, 5606.906653202627, 5679.403662615448, 4065.780265920271, 4069.674426045909, 4080.449139366207, 4091.959080409217, 4101.405296232029, 4150.481189851269, 4156.25187466259, 4156.729812562174, 4161.604647558538, 4161.687873409506, 4569.725816451024, 4635.860924172281, 4670.462896766848, 4710.26990816424, 4721.8347357842995, 5366.812161574404, 5401.513863752281, 5409.891802163935, 5410.269613602192, 5420.864478388072, 1406.606150277924, 1430.542226487514, 1432.1264028942337, 1445.2340259662396, 1445.4001589340305, 871.901404230674, 940.3652534539159, 945.6122989574242, 947.1759569174862, 960.5437417226761, 5029.723365214875, 5119.283300337956, 5192.378782883237, 5309.628326017219, 5309.8938021239355, 5595.63628364155, 5604.449975261246, 5607.607467477319, 5621.662700237999, 5638.661680299113, 5101.54605937306, 5231.032259032091, 5284.841454756363, 5286.471352864683, 5291.444398338196, 2906.5640153977074, 2932.1643331650375, 2940.705929407085, 2942.80871743336, 2950.2181921790743, 5680.77276908919, 5701.800436984686, 5702.51528620072, 5705.372409035002, 5705.5720820938595, 5400.324959380077, 5570.554355651539, 5638.35158956717, 5653.519450846724, 5685.744141513642, 5691.544676425793, 5695.5443564514735, 5699.715014249271, 5733.369329373765, 5777.942220577908, 5356.544693701079, 5568.443155684399, 5588.776448941997, 5604.8038318658655, 5612.130119831432, 5543.584231182596, 5556.861078473071, 5560.777568897199, 5561.6641010774765, 5565.248691426606, 5768.826935191783, 5810.0, 5815.505682017076, 5822.592418530662, 5834.504067154339, 3933.8671559487157, 4041.9797901010306, 4044.7168698190844, 4071.7556946582113, 4075.2257071156387, 5583.581231407742, 5585.385607583082, 5593.608447408642, 5596.188552659923, 5604.113881351189, 5438.673679579238, 5440.6735595864375, 5455.18172274162, 5463.0, 5469.288992430958, 5205.0, 5408.513233808976, 5455.645383050248, 5460.235567020541, 5464.453554644663, 5388.545092824994, 5398.5951053671915, 5401.839923644712, 5402.75687594067, 5409.4590540947165, 5209.739513024258, 5223.503767142115, 5371.838844834661, 5428.755705993319, 5444.366689993066, 5258.579313654975, 5276.868078298074, 5299.549538289289, 5306.628536002443, 5311.256424100707], "value": 4164.399439802763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.0886422996059, 763.45794485915, 792.9682812687493, 794.9483283586567, 832.9875051874221, 15633.530994070168, 16982.83017169828, 17076.573085672866, 17086.65826683467, 17131.74302385465, 15242.085474871488, 15310.234488275597, 15335.923320383383, 15347.462838800644, 15347.616309592266, 654.2802916791538, 663.6449499517759, 771.7877583664509, 774.6978678315476, 793.6388943030908, 784.1374488063142, 790.2729488870253, 797.2744802229972, 797.9920200797976, 798.409177208867, 846.9788255293636, 847.894013248344, 848.0628905059913, 848.1179573243819, 848.3001523742906, 685.0546246180289, 695.1276148433683, 841.0454134557291, 842.3513894301353, 842.9325653947669, 588.7556663984441, 590.6633219065135, 603.8973374526341, 604.1511676095049, 607.0439058482863, 15027.398904043825, 15031.248437578077, 15038.172900490468, 15063.54809355721, 15065.09609423438, 13941.233232172226, 13965.79051314231, 14100.647483812883, 14219.50231741884, 14232.644183895382, 12217.144799864012, 12268.141230113895, 12321.307689244653, 12561.811572826415, 12723.491060357575, 4396.538363471821, 4454.754988475633, 4459.0, 4466.843660471868, 4476.261416866213, 76784.0, 77675.61162194153, 77693.3383996962, 82207.58896205541, 83127.99999999939, 11318.924702153283, 11340.829887551694, 11695.532178712756, 11752.177347585757, 11888.702782430508, 21630.35108946734, 21882.89058554697, 21958.780412195993, 21967.560648786934, 22043.448913777283, 7619.314261716361, 7778.727744528915, 7898.0, 8112.675492980333, 8440.915590844135, 4468.575485328954, 4471.709338893027, 4560.794764235618, 4645.790939407735, 4661.417322834645, 3581.4627805828814, 3676.338259113332, 3680.723945704083, 3693.5567731872347, 3702.444633304972, 684.387473211473, 686.5777546808777, 707.1867352544615, 710.1159056974101, 731.6012773038707, 565.1889538512248, 589.1751547832982, 678.3860606151441, 704.5091571264372, 728.6356821589205, 9887.950560247153, 10101.242406819518, 10252.179825613934, 10304.330218535772, 10323.0, 618.4125081172904, 636.7866764633807, 667.8330417395651, 688.5111570784799, 700.1458220970408, 4768.809247630125, 4959.776810043557, 4986.227134794112, 4993.50064993505, 5002.549770520671, 72021.63989180021, 72313.0, 96308.0, 126673.36663316809, 130756.0, 61280.69359653263, 89814.0, 107343.0, 107528.0, 115842.0, 59866.40133598696, 70107.64946175237, 74348.0, 75170.24829751633, 77412.0, 9058.773530661787, 9117.17945384892, 9467.763305917408, 9593.856092158763, 9831.557579909064, 51143.744281278356, 52052.47947520476, 52751.0, 52798.0, 53156.2026569594, 40788.79605601953, 58929.0, 72488.63755681188, 73016.26983730095, 73301.26698732945, 12288.569900053813, 12384.690382740144, 12522.436490357773, 12915.418806153933, 13090.60728178118, 13000.609981700563, 13404.195748255135, 13699.0, 13765.793513097111, 13809.171449713049, 13587.728245435233, 13590.864091359355, 13705.383257753225, 13989.860101398855, 14352.210628415538, 13422.328883555978, 13782.793258101337, 13883.097598656055, 13895.722085558435, 14333.354999025278, 12777.425015874494, 13169.604911852659, 13420.194788312732, 13969.371378287799, 13980.44078236859, 10480.842787358044, 10589.205809564159, 10993.890061099286, 11058.557657693602, 11639.185257031926, 11188.552457901593, 11288.604898828502, 11489.885101149215, 11492.425378730863, 11516.42417879086], "value": 7466.084478423469, "unit": "score"}], "name": "dromaeo_css", "value": 7198.683855919076, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 118.0, 174.0, 120.0, 120.0, 124.0, 118.0, 162.0, 117.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 160.0, 161.0, 163.0, 163.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 102.0, 76.0, 76.0, 76.0, 76.0, 107.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 80.0, 82.0, 80.0, 107.0, 81.0, 81.0, 113.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 50.0, 52.0, 52.0, 53.0, 53.0, 55.0, 55.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 83.0, 79.0, 80.0, 80.0, 79.0, 87.0, 82.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 122.0, 121.0, 130.0, 126.0, 123.0, 124.0, 165.0, 131.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 166.0, 171.0, 164.0, 164.0, 172.0, 167.0, 163.0, 168.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 64.0, 64.0, 68.0, 64.0, 65.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1489.9, "alertThreshold": 2.0}]} 07:00:59 INFO - Return code: 0 07:00:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:00:59 INFO - # TBPL SUCCESS # 07:00:59 INFO - Running post-action listener: _resource_record_post_action 07:00:59 INFO - [mozharness: 2016-09-28 14:00:59.104839Z] Finished run-tests step (success) 07:00:59 INFO - Running post-run listener: _resource_record_post_run 07:00:59 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392953856; Read time: 224; Write time: 268064 07:00:59 INFO - TinderboxPrint: CPU usage
13.0% 07:00:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 224 07:00:59 INFO - TinderboxPrint: I/O write bytes / time
392,953,856 / 268,064 07:00:59 INFO - TinderboxPrint: CPU idle
8,291.4 (87.0%) 07:00:59 INFO - TinderboxPrint: CPU user
1,194.2 (12.5%) 07:00:59 INFO - TinderboxPrint: Swap in / out
0 / 0 07:00:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103956480; Read time: 0; Write time: 56408 07:00:59 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288997376; Read time: 204; Write time: 211656 07:00:59 INFO - Running post-run listener: _upload_blobber_files 07:00:59 INFO - Blob upload gear active. 07:00:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:59 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 07:00:59 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'] 07:00:59 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 07:01:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:01:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:03 INFO - (blobuploader) - INFO - Done attempting. 07:01:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:01:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:01:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:04 INFO - (blobuploader) - INFO - Done attempting. 07:01:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:01:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:01:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:05 INFO - (blobuploader) - INFO - Done attempting. 07:01:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:05 INFO - Return code: 0 07:01:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:01:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:01:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524921a498437fac4ef416275e6e9d8a18770ded34cf0eb026b634d7ea7b3998ea7e73819443f065acda690bc6620749d762c5769266e8edcdf603a7d17850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c89e2539f5ae80ee2b2e597d2bae70c5b2922ca5714f4e591f4c4dc5edd0c3a2383fbf612875732432266fed0fa7ac55cb32d74c4c975cae832e67956d0214", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7d278034d5ed222c5e2bd87beddbbe2a3ad82da50b6564fc13bb9a226538508e40c94858c112df5490cc4a4b7a4d389858e1cb84eeb4f1d01c972ae70afed4"} 07:01:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:01:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:01:05 INFO - Contents: 07:01:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524921a498437fac4ef416275e6e9d8a18770ded34cf0eb026b634d7ea7b3998ea7e73819443f065acda690bc6620749d762c5769266e8edcdf603a7d17850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c89e2539f5ae80ee2b2e597d2bae70c5b2922ca5714f4e591f4c4dc5edd0c3a2383fbf612875732432266fed0fa7ac55cb32d74c4c975cae832e67956d0214", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7d278034d5ed222c5e2bd87beddbbe2a3ad82da50b6564fc13bb9a226538508e40c94858c112df5490cc4a4b7a4d389858e1cb84eeb4f1d01c972ae70afed4"} 07:01:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:05 INFO - Copying logs to upload dir... 07:01:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:01:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.957475 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-28 07:01:04.773727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 07:01:04.778573) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 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/c524921a498437fac4ef416275e6e9d8a18770ded34cf0eb026b634d7ea7b3998ea7e73819443f065acda690bc6620749d762c5769266e8edcdf603a7d17850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c89e2539f5ae80ee2b2e597d2bae70c5b2922ca5714f4e591f4c4dc5edd0c3a2383fbf612875732432266fed0fa7ac55cb32d74c4c975cae832e67956d0214", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7d278034d5ed222c5e2bd87beddbbe2a3ad82da50b6564fc13bb9a226538508e40c94858c112df5490cc4a4b7a4d389858e1cb84eeb4f1d01c972ae70afed4"} build_url:https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/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/c524921a498437fac4ef416275e6e9d8a18770ded34cf0eb026b634d7ea7b3998ea7e73819443f065acda690bc6620749d762c5769266e8edcdf603a7d17850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c89e2539f5ae80ee2b2e597d2bae70c5b2922ca5714f4e591f4c4dc5edd0c3a2383fbf612875732432266fed0fa7ac55cb32d74c4c975cae832e67956d0214", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7d278034d5ed222c5e2bd87beddbbe2a3ad82da50b6564fc13bb9a226538508e40c94858c112df5490cc4a4b7a4d389858e1cb84eeb4f1d01c972ae70afed4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 07:01:04.806277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 07:01:04.806577) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475070021.453778-452443498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 07:01:04.886962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 07:01:04.890311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 07:01:04.890621) ========= ========= Total master_lag: 0.20 =========