builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1475089928.06 results: success (0) buildid: 20160928093037 builduid: d9ce418ed74942e8ac83eab6bd20319d revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.063101) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.063910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.064523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.087348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.087766) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 12:12:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-09-28 12:12:08 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.228237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.228626) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:08.279143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 12:12:08.279547) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eda310265741fb26bbd91a92017bc6337fcc8de6 --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 eda310265741fb26bbd91a92017bc6337fcc8de6 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 12:12:08,798 truncating revision to first 12 chars 2016-09-28 12:12:08,798 Setting DEBUG logging. 2016-09-28 12:12:08,798 attempt 1/10 2016-09-28 12:12:08,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eda310265741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 12:12:09,484 unpacking tar archive at: fx-team-eda310265741/testing/mozharness/ program finished with exit code 0 elapsedTime=1.776479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 12:12:10.070054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:10.070423) ========= script_repo_revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:10.070917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:10.071222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 12:12:10.080331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 12:12:10.080742) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:12:10 INFO - MultiFileLogger online at 20160928 12:12:10 in /builds/slave/test 12:12:10 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 12:12:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:12:10 INFO - {'append_to_log': False, 12:12:10 INFO - 'base_work_dir': '/builds/slave/test', 12:12:10 INFO - 'blob_upload_branch': 'Fx-Team', 12:12:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:12:10 INFO - 'branch': 'Fx-Team', 12:12:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:12:10 INFO - 'config_files': ('talos/linux_config.py',), 12:12:10 INFO - 'default_actions': ('clobber', 12:12:10 INFO - 'read-buildbot-config', 12:12:10 INFO - 'download-and-extract', 12:12:10 INFO - 'populate-webroot', 12:12:10 INFO - 'create-virtualenv', 12:12:10 INFO - 'install', 12:12:10 INFO - 'run-tests'), 12:12:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:12:10 INFO - 'download_minidump_stackwalk': True, 12:12:10 INFO - 'download_symbols': 'ondemand', 12:12:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:12:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:12:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:12:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:12:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:12:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:12:10 INFO - 'installer_path': 'installer.exe', 12:12:10 INFO - 'log_level': 'info', 12:12:10 INFO - 'log_name': 'talos', 12:12:10 INFO - 'log_to_console': True, 12:12:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:12:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:12:10 INFO - 'opt_config_files': (), 12:12:10 INFO - 'pip_index': False, 12:12:10 INFO - 'sps_profile': False, 12:12:10 INFO - 'sps_profile_interval': 0, 12:12:10 INFO - 'suite': 'dromaeojs', 12:12:10 INFO - 'system_bits': '32', 12:12:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:12:10 INFO - 'title': 'talos-linux64-ix-041', 12:12:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:12:10 INFO - 'use_talos_json': True, 12:12:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:12:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:12:10 INFO - 'work_dir': 'build'} 12:12:10 INFO - [mozharness: 2016-09-28 19:12:10.699346Z] Running clobber step. 12:12:10 INFO - Running pre-action listener: _resource_record_pre_action 12:12:10 INFO - Running main action method: clobber 12:12:10 INFO - rmtree: /builds/slave/test/build 12:12:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:12:11 INFO - Running post-action listener: _resource_record_post_action 12:12:11 INFO - [mozharness: 2016-09-28 19:12:11.159489Z] Finished clobber step (success) 12:12:11 INFO - [mozharness: 2016-09-28 19:12:11.159588Z] Running read-buildbot-config step. 12:12:11 INFO - Running pre-action listener: _resource_record_pre_action 12:12:11 INFO - Running main action method: read_buildbot_config 12:12:11 INFO - Using buildbot properties: 12:12:11 INFO - { 12:12:11 INFO - "project": "", 12:12:11 INFO - "product": "firefox", 12:12:11 INFO - "script_repo_revision": "production", 12:12:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:12:11 INFO - "repository": "", 12:12:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:12:11 INFO - "buildid": "20160928093037", 12:12:11 INFO - "pgo_build": "True", 12:12:11 INFO - "basedir": "/builds/slave/test", 12:12:11 INFO - "buildnumber": 1085, 12:12:11 INFO - "slavename": "talos-linux64-ix-041", 12:12:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:12:11 INFO - "platform": "ubuntu64_hw", 12:12:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:12:11 INFO - "branch": "fx-team", 12:12:11 INFO - "repo_path": "integration/fx-team", 12:12:11 INFO - "revision": "eda310265741fb26bbd91a92017bc6337fcc8de6", 12:12:11 INFO - "stage_platform": "linux64-pgo", 12:12:11 INFO - "builduid": "d9ce418ed74942e8ac83eab6bd20319d", 12:12:11 INFO - "slavebuilddir": "test" 12:12:11 INFO - } 12:12:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:12:11 INFO - Running post-action listener: _resource_record_post_action 12:12:11 INFO - [mozharness: 2016-09-28 19:12:11.162008Z] Finished read-buildbot-config step (success) 12:12:11 INFO - [mozharness: 2016-09-28 19:12:11.162095Z] Running download-and-extract step. 12:12:11 INFO - Running pre-action listener: _resource_record_pre_action 12:12:11 INFO - Running main action method: download_and_extract 12:12:11 INFO - mkdir: /builds/slave/test/build/tests 12:12:11 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')]} 12:12:11 INFO - trying https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/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 12:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/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 12:12:11 INFO - Downloaded 1361 bytes. 12:12:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:12:11 INFO - Using the following test package requirements: 12:12:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:12:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:12:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:12:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'jsshell-linux-x86_64.zip'], 12:12:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:12:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:12:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:12:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:12:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:12:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:12:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:12:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:12:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:12:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:12:12 INFO - Expected file size: 21987205 12:12:12 INFO - Content-Encoding None 12:12:12 INFO - Content-Type application/zip 12:12:12 INFO - Http code 200 12:12:16 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 12:12:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:12:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:12:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:12:17 INFO - Expected file size: 21987205 12:12:17 INFO - Content-Encoding None 12:12:17 INFO - Content-Type application/zip 12:12:17 INFO - Http code 200 12:12:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:12:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:12:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:12:22 INFO - Expected file size: 14414067 12:12:22 INFO - Content-Encoding None 12:12:22 INFO - Content-Type application/zip 12:12:22 INFO - Http code 200 12:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:22 INFO - trying https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:12:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/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 12:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/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 12:12:24 INFO - Downloaded 59739016 bytes. 12:12:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:12:24 INFO - mkdir: /builds/slave/test/properties 12:12:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:12:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:12:24 INFO - Contents: 12:12:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:12:24 INFO - Running post-action listener: _resource_record_post_action 12:12:24 INFO - Running post-action listener: set_extra_try_arguments 12:12:24 INFO - [mozharness: 2016-09-28 19:12:24.783389Z] Finished download-and-extract step (success) 12:12:24 INFO - [mozharness: 2016-09-28 19:12:24.783614Z] Running populate-webroot step. 12:12:24 INFO - Running pre-action listener: _resource_record_pre_action 12:12:24 INFO - Running main action method: populate_webroot 12:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:12:24 INFO - '--tppagecycles', 12:12:24 INFO - '7'], 12:12:24 INFO - 'tests': ['tsvgm']}}, 12:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:12:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['damp', 'tps']}, 12:12:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'tests': ['damp', 'tps']}, 12:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['dromaeo_dom']}, 12:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['basic_compositor_video']}, 12:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['a11yr', 12:12:24 INFO - 'ts_paint', 12:12:24 INFO - 'tpaint', 12:12:24 INFO - 'sessionrestore', 12:12:24 INFO - 'sessionrestore_no_auto_restore', 12:12:24 INFO - 'tabpaint']}, 12:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['tsvgx', 12:12:24 INFO - 'tsvgr_opacity', 12:12:24 INFO - 'tart', 12:12:24 INFO - 'tscrollx', 12:12:24 INFO - 'cart']}, 12:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:12:24 INFO - 'tsvgr_opacity', 12:12:24 INFO - 'tart', 12:12:24 INFO - 'tscrollx', 12:12:24 INFO - 'cart']}, 12:12:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'talos_options': ['--disable-e10s'], 12:12:24 INFO - 'tests': ['tp5o']}, 12:12:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'tests': ['tp5o']}, 12:12:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'talos_options': ['--disable-e10s', 12:12:24 INFO - '--xperf_path', 12:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:24 INFO - 'tests': ['tp5n']}, 12:12:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:24 INFO - 'talos_options': ['--xperf_path', 12:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:24 INFO - 'tests': ['tp5n']}}, 12:12:24 INFO - 'talos.zip': {'path': '', 12:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:12:24 INFO - Running post-action listener: _resource_record_post_action 12:12:24 INFO - [mozharness: 2016-09-28 19:12:24.805215Z] Finished populate-webroot step (success) 12:12:24 INFO - [mozharness: 2016-09-28 19:12:24.805302Z] Running create-virtualenv step. 12:12:24 INFO - Running pre-action listener: _resource_record_pre_action 12:12:24 INFO - Running main action method: create_virtualenv 12:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:12:24 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 12:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:12:24 INFO - Using real prefix '/usr' 12:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:12:27 INFO - Installing pip.................done. 12:12:27 INFO - Return code: 0 12:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:12:27 INFO - Reading from file tmpfile_stdout 12:12:27 INFO - Output received: 12:12:27 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) 12:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:12:27 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')]} 12:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:27 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')]} 12:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:27 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:27 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 12:12:27 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 12:12:27 INFO - Using env: {'DISPLAY': ':0', 12:12:27 INFO - 'HOME': '/home/cltbld', 12:12:27 INFO - 'LANG': 'en_US.UTF-8', 12:12:27 INFO - 'LANGUAGE': 'en_US:en', 12:12:27 INFO - 'LOGNAME': 'cltbld', 12:12:27 INFO - 'MAIL': '/var/mail/cltbld', 12:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:27 INFO - 'MOZ_NO_REMOTE': '1', 12:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:27 INFO - 'NO_EM_RESTART': '1', 12:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:27 INFO - 'PWD': '/builds/slave/test', 12:12:27 INFO - 'SHELL': '/bin/bash', 12:12:27 INFO - 'SHLVL': '1', 12:12:27 INFO - 'TERM': 'linux', 12:12:27 INFO - 'TMOUT': '86400', 12:12:27 INFO - 'USER': 'cltbld', 12:12:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:27 INFO - '_': '/tools/buildbot/bin/python'} 12:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:27 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 12:12:27 INFO - Cleaning up... 12:12:27 INFO - Return code: 0 12:12:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:12:27 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')]} 12:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:27 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')]} 12:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:27 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:27 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 12:12:27 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 12:12:27 INFO - Using env: {'DISPLAY': ':0', 12:12:27 INFO - 'HOME': '/home/cltbld', 12:12:27 INFO - 'LANG': 'en_US.UTF-8', 12:12:27 INFO - 'LANGUAGE': 'en_US:en', 12:12:27 INFO - 'LOGNAME': 'cltbld', 12:12:27 INFO - 'MAIL': '/var/mail/cltbld', 12:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:27 INFO - 'MOZ_NO_REMOTE': '1', 12:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:27 INFO - 'NO_EM_RESTART': '1', 12:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:27 INFO - 'PWD': '/builds/slave/test', 12:12:27 INFO - 'SHELL': '/bin/bash', 12:12:27 INFO - 'SHLVL': '1', 12:12:27 INFO - 'TERM': 'linux', 12:12:27 INFO - 'TMOUT': '86400', 12:12:27 INFO - 'USER': 'cltbld', 12:12:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:27 INFO - '_': '/tools/buildbot/bin/python'} 12:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:27 INFO - Downloading/unpacking psutil>=3.1.1 12:12:27 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 12:12:27 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 12:12:27 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 12:12:27 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 12:12:27 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 12:12:27 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 12:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:29 INFO - Installing collected packages: psutil 12:12:29 INFO - Running setup.py install for psutil 12:12:29 INFO - building 'psutil._psutil_linux' extension 12:12:29 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 12:12:29 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 12:12:29 INFO - building 'psutil._psutil_posix' extension 12:12:29 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 12:12:29 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 12:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:30 INFO - Successfully installed psutil 12:12:30 INFO - Cleaning up... 12:12:30 INFO - Return code: 0 12:12:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:30 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:30 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 12:12:30 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 12:12:30 INFO - Using env: {'DISPLAY': ':0', 12:12:30 INFO - 'HOME': '/home/cltbld', 12:12:30 INFO - 'LANG': 'en_US.UTF-8', 12:12:30 INFO - 'LANGUAGE': 'en_US:en', 12:12:30 INFO - 'LOGNAME': 'cltbld', 12:12:30 INFO - 'MAIL': '/var/mail/cltbld', 12:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:30 INFO - 'MOZ_NO_REMOTE': '1', 12:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:30 INFO - 'NO_EM_RESTART': '1', 12:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:30 INFO - 'PWD': '/builds/slave/test', 12:12:30 INFO - 'SHELL': '/bin/bash', 12:12:30 INFO - 'SHLVL': '1', 12:12:30 INFO - 'TERM': 'linux', 12:12:30 INFO - 'TMOUT': '86400', 12:12:30 INFO - 'USER': 'cltbld', 12:12:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:30 INFO - '_': '/tools/buildbot/bin/python'} 12:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:12:30 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 12:12:30 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 12:12:30 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 12:12:30 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 12:12:30 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 12:12:30 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 12:12:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:12:32 INFO - Installing collected packages: mozsystemmonitor 12:12:32 INFO - Running setup.py install for mozsystemmonitor 12:12:32 INFO - Successfully installed mozsystemmonitor 12:12:32 INFO - Cleaning up... 12:12:32 INFO - Return code: 0 12:12:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:32 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:32 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 12:12:32 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 12:12:32 INFO - Using env: {'DISPLAY': ':0', 12:12:32 INFO - 'HOME': '/home/cltbld', 12:12:32 INFO - 'LANG': 'en_US.UTF-8', 12:12:32 INFO - 'LANGUAGE': 'en_US:en', 12:12:32 INFO - 'LOGNAME': 'cltbld', 12:12:32 INFO - 'MAIL': '/var/mail/cltbld', 12:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:32 INFO - 'MOZ_NO_REMOTE': '1', 12:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:32 INFO - 'NO_EM_RESTART': '1', 12:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:32 INFO - 'PWD': '/builds/slave/test', 12:12:32 INFO - 'SHELL': '/bin/bash', 12:12:32 INFO - 'SHLVL': '1', 12:12:32 INFO - 'TERM': 'linux', 12:12:32 INFO - 'TMOUT': '86400', 12:12:32 INFO - 'USER': 'cltbld', 12:12:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:32 INFO - '_': '/tools/buildbot/bin/python'} 12:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:32 INFO - Downloading/unpacking jsonschema==2.5.1 12:12:32 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 12:12:32 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 12:12:32 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 12:12:32 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 12:12:32 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 12:12:32 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 12:12:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:12:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:34 INFO - Downloading functools32-3.2.3-2.tar.gz 12:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:12:34 INFO - warning: no files found matching '*.txt' 12:12:34 INFO - no previously-included directories found matching 'build' 12:12:34 INFO - no previously-included directories found matching 'dist' 12:12:34 INFO - no previously-included directories found matching '.git*' 12:12:34 INFO - Installing collected packages: jsonschema, functools32 12:12:34 INFO - Running setup.py install for functools32 12:12:34 INFO - warning: no files found matching '*.txt' 12:12:34 INFO - no previously-included directories found matching 'build' 12:12:34 INFO - no previously-included directories found matching 'dist' 12:12:34 INFO - no previously-included directories found matching '.git*' 12:12:34 INFO - Successfully installed jsonschema functools32 12:12:34 INFO - Cleaning up... 12:12:35 INFO - Return code: 0 12:12:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:35 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 12:12:35 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 12:12:35 INFO - Using env: {'DISPLAY': ':0', 12:12:35 INFO - 'HOME': '/home/cltbld', 12:12:35 INFO - 'LANG': 'en_US.UTF-8', 12:12:35 INFO - 'LANGUAGE': 'en_US:en', 12:12:35 INFO - 'LOGNAME': 'cltbld', 12:12:35 INFO - 'MAIL': '/var/mail/cltbld', 12:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:35 INFO - 'MOZ_NO_REMOTE': '1', 12:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:35 INFO - 'NO_EM_RESTART': '1', 12:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:35 INFO - 'PWD': '/builds/slave/test', 12:12:35 INFO - 'SHELL': '/bin/bash', 12:12:35 INFO - 'SHLVL': '1', 12:12:35 INFO - 'TERM': 'linux', 12:12:35 INFO - 'TMOUT': '86400', 12:12:35 INFO - 'USER': 'cltbld', 12:12:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:35 INFO - '_': '/tools/buildbot/bin/python'} 12:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:12:35 INFO - Cleaning up... 12:12:35 INFO - Return code: 0 12:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:35 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 12:12:35 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 12:12:35 INFO - Using env: {'DISPLAY': ':0', 12:12:35 INFO - 'HOME': '/home/cltbld', 12:12:35 INFO - 'LANG': 'en_US.UTF-8', 12:12:35 INFO - 'LANGUAGE': 'en_US:en', 12:12:35 INFO - 'LOGNAME': 'cltbld', 12:12:35 INFO - 'MAIL': '/var/mail/cltbld', 12:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:35 INFO - 'MOZ_NO_REMOTE': '1', 12:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:35 INFO - 'NO_EM_RESTART': '1', 12:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:35 INFO - 'PWD': '/builds/slave/test', 12:12:35 INFO - 'SHELL': '/bin/bash', 12:12:35 INFO - 'SHLVL': '1', 12:12:35 INFO - 'TERM': 'linux', 12:12:35 INFO - 'TMOUT': '86400', 12:12:35 INFO - 'USER': 'cltbld', 12:12:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:35 INFO - '_': '/tools/buildbot/bin/python'} 12:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:12:35 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 12:12:35 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 12:12:35 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 12:12:35 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 12:12:35 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 12:12:35 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 12:12:37 INFO - Downloading blobuploader-1.2.4.tar.gz 12:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:12:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:12:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:37 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 12:12:38 INFO - Downloading docopt-0.6.1.tar.gz 12:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:12:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:12:38 INFO - Running setup.py install for blobuploader 12:12:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:12:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:12:38 INFO - Running setup.py install for requests 12:12:38 INFO - Running setup.py install for docopt 12:12:38 INFO - Successfully installed blobuploader requests docopt 12:12:38 INFO - Cleaning up... 12:12:38 INFO - Return code: 0 12:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:38 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:38 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 12:12:38 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 12:12:38 INFO - Using env: {'DISPLAY': ':0', 12:12:38 INFO - 'HOME': '/home/cltbld', 12:12:38 INFO - 'LANG': 'en_US.UTF-8', 12:12:38 INFO - 'LANGUAGE': 'en_US:en', 12:12:38 INFO - 'LOGNAME': 'cltbld', 12:12:38 INFO - 'MAIL': '/var/mail/cltbld', 12:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:38 INFO - 'MOZ_NO_REMOTE': '1', 12:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:38 INFO - 'NO_EM_RESTART': '1', 12:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:38 INFO - 'PWD': '/builds/slave/test', 12:12:38 INFO - 'SHELL': '/bin/bash', 12:12:38 INFO - 'SHLVL': '1', 12:12:38 INFO - 'TERM': 'linux', 12:12:38 INFO - 'TMOUT': '86400', 12:12:38 INFO - 'USER': 'cltbld', 12:12:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:38 INFO - '_': '/tools/buildbot/bin/python'} 12:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:12:38 INFO - Running setup.py (path:/tmp/pip-aWhpVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:12:39 INFO - Running setup.py (path:/tmp/pip-EZSVH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:12:39 INFO - Running setup.py (path:/tmp/pip-bgYpF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:12:39 INFO - Running setup.py (path:/tmp/pip-6pCIHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:12:39 INFO - Running setup.py (path:/tmp/pip-p5igZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:12:39 INFO - Running setup.py (path:/tmp/pip-rHglKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:12:39 INFO - Running setup.py (path:/tmp/pip-NITb12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:12:39 INFO - Running setup.py (path:/tmp/pip-ymbn7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:12:39 INFO - Running setup.py (path:/tmp/pip-0c7_wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:12:39 INFO - Running setup.py (path:/tmp/pip-wYouRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:12:39 INFO - Running setup.py (path:/tmp/pip-64ha3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:12:39 INFO - Running setup.py (path:/tmp/pip-0Ib0NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:12:39 INFO - Running setup.py (path:/tmp/pip-rQL9zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:12:39 INFO - Running setup.py (path:/tmp/pip-ugvnNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:40 INFO - Running setup.py (path:/tmp/pip-iswBq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:12:40 INFO - Running setup.py (path:/tmp/pip-HVpMvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:12:40 INFO - Running setup.py (path:/tmp/pip-QYIQMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:12:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:12:40 INFO - Running setup.py install for manifestparser 12:12:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:12:40 INFO - Running setup.py install for mozcrash 12:12:40 INFO - Running setup.py install for mozdebug 12:12:40 INFO - Running setup.py install for mozdevice 12:12:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:12:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:12:40 INFO - Running setup.py install for mozfile 12:12:40 INFO - Running setup.py install for mozhttpd 12:12:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:12:40 INFO - Running setup.py install for mozinfo 12:12:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:12:40 INFO - Running setup.py install for mozInstall 12:12:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Running setup.py install for mozleak 12:12:41 INFO - Running setup.py install for mozlog 12:12:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Running setup.py install for moznetwork 12:12:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Running setup.py install for mozprocess 12:12:41 INFO - Running setup.py install for mozprofile 12:12:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Running setup.py install for mozrunner 12:12:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:12:41 INFO - Running setup.py install for mozscreenshot 12:12:41 INFO - Running setup.py install for moztest 12:12:41 INFO - Running setup.py install for mozversion 12:12:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:12:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:12:42 INFO - Cleaning up... 12:12:42 INFO - Return code: 0 12:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:42 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:42 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 12:12:42 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 12:12:42 INFO - Using env: {'DISPLAY': ':0', 12:12:42 INFO - 'HOME': '/home/cltbld', 12:12:42 INFO - 'LANG': 'en_US.UTF-8', 12:12:42 INFO - 'LANGUAGE': 'en_US:en', 12:12:42 INFO - 'LOGNAME': 'cltbld', 12:12:42 INFO - 'MAIL': '/var/mail/cltbld', 12:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:42 INFO - 'MOZ_NO_REMOTE': '1', 12:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:42 INFO - 'NO_EM_RESTART': '1', 12:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:42 INFO - 'PWD': '/builds/slave/test', 12:12:42 INFO - 'SHELL': '/bin/bash', 12:12:42 INFO - 'SHLVL': '1', 12:12:42 INFO - 'TERM': 'linux', 12:12:42 INFO - 'TMOUT': '86400', 12:12:42 INFO - 'USER': 'cltbld', 12:12:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:42 INFO - '_': '/tools/buildbot/bin/python'} 12:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:12:42 INFO - Running setup.py (path:/tmp/pip-FlDOzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:12:42 INFO - Running setup.py (path:/tmp/pip-pk0kOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:12:42 INFO - Running setup.py (path:/tmp/pip-o7OhAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:12:42 INFO - Running setup.py (path:/tmp/pip-RarFXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:12:42 INFO - Running setup.py (path:/tmp/pip-GEhYHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:12:42 INFO - Running setup.py (path:/tmp/pip-ey4LgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:12:42 INFO - Running setup.py (path:/tmp/pip-ORD5O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:12:42 INFO - Running setup.py (path:/tmp/pip-KJ9R2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:12:42 INFO - Running setup.py (path:/tmp/pip-knOynI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:12:42 INFO - Running setup.py (path:/tmp/pip-Sfu7sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:12:42 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)) 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:12:42 INFO - Running setup.py (path:/tmp/pip-qn5M6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:12:43 INFO - Running setup.py (path:/tmp/pip-vHpK2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:12:43 INFO - Running setup.py (path:/tmp/pip-cs3r2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:12:43 INFO - Running setup.py (path:/tmp/pip-zFRcp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:43 INFO - Running setup.py (path:/tmp/pip-e95all-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:12:43 INFO - Running setup.py (path:/tmp/pip-u_94xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:12:43 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)) 12:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:12:43 INFO - Running setup.py (path:/tmp/pip-7BZmff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:12:43 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)) 12:12:43 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)) 12:12:43 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)) 12:12:43 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)) 12:12:43 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)) 12:12:43 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)) 12:12:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:12:43 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 12:12:43 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 12:12:43 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 12:12:43 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 12:12:43 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 12:12:43 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 12:12:45 INFO - Downloading blessings-1.6.tar.gz 12:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:12:45 INFO - Installing collected packages: blessings 12:12:45 INFO - Running setup.py install for blessings 12:12:45 INFO - Successfully installed blessings 12:12:45 INFO - Cleaning up... 12:12:45 INFO - Return code: 0 12:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:12:45 INFO - Reading from file tmpfile_stdout 12:12:45 INFO - Current package versions: 12:12:45 INFO - argparse == 1.2.1 12:12:45 INFO - blessings == 1.6 12:12:45 INFO - blobuploader == 1.2.4 12:12:45 INFO - docopt == 0.6.1 12:12:45 INFO - functools32 == 3.2.3-2 12:12:45 INFO - jsonschema == 2.5.1 12:12:45 INFO - manifestparser == 1.1 12:12:45 INFO - mozInstall == 1.12 12:12:45 INFO - mozcrash == 0.17 12:12:45 INFO - mozdebug == 0.1 12:12:45 INFO - mozdevice == 0.48 12:12:45 INFO - mozfile == 1.2 12:12:45 INFO - mozhttpd == 0.7 12:12:45 INFO - mozinfo == 0.9 12:12:45 INFO - mozleak == 0.1 12:12:45 INFO - mozlog == 3.4 12:12:45 INFO - moznetwork == 0.27 12:12:45 INFO - mozprocess == 0.23 12:12:45 INFO - mozprofile == 0.28 12:12:45 INFO - mozrunner == 6.12 12:12:45 INFO - mozscreenshot == 0.1 12:12:45 INFO - mozsystemmonitor == 0.3 12:12:45 INFO - moztest == 0.7 12:12:45 INFO - mozversion == 1.4 12:12:45 INFO - psutil == 3.1.1 12:12:45 INFO - requests == 1.2.3 12:12:45 INFO - wsgiref == 0.1.2 12:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:45 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:45 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 12:12:45 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 12:12:45 INFO - Using env: {'DISPLAY': ':0', 12:12:45 INFO - 'HOME': '/home/cltbld', 12:12:45 INFO - 'LANG': 'en_US.UTF-8', 12:12:45 INFO - 'LANGUAGE': 'en_US:en', 12:12:45 INFO - 'LOGNAME': 'cltbld', 12:12:45 INFO - 'MAIL': '/var/mail/cltbld', 12:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:45 INFO - 'MOZ_NO_REMOTE': '1', 12:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:45 INFO - 'NO_EM_RESTART': '1', 12:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:45 INFO - 'PWD': '/builds/slave/test', 12:12:45 INFO - 'SHELL': '/bin/bash', 12:12:45 INFO - 'SHLVL': '1', 12:12:45 INFO - 'TERM': 'linux', 12:12:45 INFO - 'TMOUT': '86400', 12:12:45 INFO - 'USER': 'cltbld', 12:12:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:45 INFO - '_': '/tools/buildbot/bin/python'} 12:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 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)) 12:12:46 INFO - Cleaning up... 12:12:46 INFO - Return code: 0 12:12:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:12:46 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')]} 12:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:46 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')]} 12:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:46 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 0x7f6fc70b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', '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 12:12:46 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 12:12:46 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 12:12:46 INFO - Using env: {'DISPLAY': ':0', 12:12:46 INFO - 'HOME': '/home/cltbld', 12:12:46 INFO - 'LANG': 'en_US.UTF-8', 12:12:46 INFO - 'LANGUAGE': 'en_US:en', 12:12:46 INFO - 'LOGNAME': 'cltbld', 12:12:46 INFO - 'MAIL': '/var/mail/cltbld', 12:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:46 INFO - 'MOZ_NO_REMOTE': '1', 12:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:46 INFO - 'NO_EM_RESTART': '1', 12:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:46 INFO - 'PWD': '/builds/slave/test', 12:12:46 INFO - 'SHELL': '/bin/bash', 12:12:46 INFO - 'SHLVL': '1', 12:12:46 INFO - 'TERM': 'linux', 12:12:46 INFO - 'TMOUT': '86400', 12:12:46 INFO - 'USER': 'cltbld', 12:12:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:46 INFO - '_': '/tools/buildbot/bin/python'} 12:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:12:46 INFO - Cleaning up... 12:12:46 INFO - Return code: 0 12:12:46 INFO - Running post-action listener: _resource_record_post_action 12:12:46 INFO - Running post-action listener: _start_resource_monitoring 12:12:46 INFO - Starting resource monitoring. 12:12:46 INFO - [mozharness: 2016-09-28 19:12:46.327773Z] Finished create-virtualenv step (success) 12:12:46 INFO - [mozharness: 2016-09-28 19:12:46.328284Z] Running install step. 12:12:46 INFO - Running pre-action listener: _resource_record_pre_action 12:12:46 INFO - Running main action method: install 12:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:12:46 INFO - Reading from file tmpfile_stdout 12:12:46 INFO - Detecting whether we're running mozinstall >=1.0... 12:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:12:46 INFO - Reading from file tmpfile_stdout 12:12:46 INFO - Output received: 12:12:46 INFO - Usage: mozinstall [options] installer 12:12:46 INFO - Options: 12:12:46 INFO - -h, --help show this help message and exit 12:12:46 INFO - -d DEST, --destination=DEST 12:12:46 INFO - Directory to install application into. [default: 12:12:46 INFO - "/builds/slave/test"] 12:12:46 INFO - --app=APP Application being installed. [default: firefox] 12:12:46 INFO - mkdir: /builds/slave/test/build/application 12:12:46 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'] 12:12:46 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 12:13:04 INFO - Reading from file tmpfile_stdout 12:13:04 INFO - Output received: 12:13:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:13:04 INFO - Running post-action listener: _resource_record_post_action 12:13:04 INFO - [mozharness: 2016-09-28 19:13:04.287765Z] Finished install step (success) 12:13:04 INFO - [mozharness: 2016-09-28 19:13:04.288008Z] Running run-tests step. 12:13:04 INFO - Running pre-action listener: _resource_record_pre_action 12:13:04 INFO - Running main action method: run_tests 12:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:04 INFO - Python 2.7.3 12:13:04 INFO - Return code: 0 12:13:04 INFO - grabbing minidump binary from tooltool 12:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:13:04 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 0x2758930>, '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 0x2759830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:04 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 12:13:04 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 12:13:04 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 12:13:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:04 INFO - Return code: 0 12:13:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:13:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:13:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:04 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/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:13:04 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/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 12:13:04 INFO - Using env: {'DISPLAY': ':0', 12:13:04 INFO - 'HOME': '/home/cltbld', 12:13:04 INFO - 'LANG': 'en_US.UTF-8', 12:13:04 INFO - 'LANGUAGE': 'en_US:en', 12:13:04 INFO - 'LOGNAME': 'cltbld', 12:13:04 INFO - 'MAIL': '/var/mail/cltbld', 12:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:04 INFO - 'MOZ_NO_REMOTE': '1', 12:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:04 INFO - 'NO_EM_RESTART': '1', 12:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:04 INFO - 'PWD': '/builds/slave/test', 12:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:04 INFO - 'SHELL': '/bin/bash', 12:13:04 INFO - 'SHLVL': '1', 12:13:04 INFO - 'TERM': 'linux', 12:13:04 INFO - 'TMOUT': '86400', 12:13:04 INFO - 'USER': 'cltbld', 12:13:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068', 12:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:04 INFO - '_': '/tools/buildbot/bin/python'} 12:13:04 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/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:13:04 INFO - mozversion application_buildid: 20160928093037 12:13:04 INFO - mozversion application_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 12:13:04 INFO - mozversion application_display_name: Nightly 12:13:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:04 INFO - mozversion application_name: Firefox 12:13:04 INFO - mozversion application_remotingname: firefox 12:13:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:13:04 INFO - mozversion application_vendor: Mozilla 12:13:04 INFO - mozversion application_version: 52.0a1 12:13:04 INFO - mozversion platform_buildid: 20160928093037 12:13:04 INFO - mozversion platform_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 12:13:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:13:04 INFO - mozversion platform_version: 52.0a1 12:13:04 INFO - using testdate: 1475089984 12:13:04 INFO - actual date: 1475089984 12:13:04 INFO - starting webserver on 'localhost:41149' 12:13:04 INFO - SUITE-START | Running 2 tests 12:13:04 INFO - TEST-START | dromaeo_css 12:13:04 INFO - operating with platform_type : linux_ 12:13:04 INFO - Initialising browser for dromaeo_css test... 12:13:04 INFO - TEST-INFO | started process 11451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe6ojkM/profile http://localhost:41149/getInfo.html) 12:13:09 INFO - PROCESS | 11451 | __metrics Screen width/height:1600/1200 12:13:09 INFO - PROCESS | 11451 | colorDepth:24 12:13:09 INFO - PROCESS | 11451 | Browser inner width/height: 1024/697 12:13:09 INFO - PROCESS | 11451 | __metrics 12:13:09 INFO - PROCESS | 11451 | 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" 12:13:09 INFO - PROCESS | 11451 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:10 INFO - PROCESS | 11451 | console.error: PushService: 12:13:10 INFO - PROCESS | 11451 | stateChangeProcessEnqueue: Error transitioning state 12:13:10 INFO - PROCESS | 11451 | UnknownError 12:13:10 INFO - TEST-INFO | 11451: exit 0 12:13:10 INFO - Browser initialized. 12:13:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:13:10 INFO - TEST-INFO | started process 11533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe6ojkM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:23 INFO - PROCESS | 11533 | RSS: Main: 173756416 12:13:23 INFO - PROCESS | 11533 | 12:14:14 INFO - PROCESS | 11533 | 1475090054599 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] 12:16:24 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41149/tests/dromaeo/cssquery-ext.html) 12:16:25 INFO - PROCESS | 11533 | RSS: Main: 320954368 12:16:25 INFO - PROCESS | 11533 | 12:19:27 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-ext.html (next: http://localhost:41149/tests/dromaeo/cssquery-jquery.html) 12:19:28 INFO - PROCESS | 11533 | RSS: Main: 268824576 12:19:28 INFO - PROCESS | 11533 | 12:22:30 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41149/tests/dromaeo/cssquery-mootools.html) 12:22:30 INFO - PROCESS | 11533 | RSS: Main: 264871936 12:22:30 INFO - PROCESS | 11533 | 12:25:32 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41149/tests/dromaeo/cssquery-prototype.html) 12:25:33 INFO - PROCESS | 11533 | RSS: Main: 268242944 12:25:33 INFO - PROCESS | 11533 | 12:28:36 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41149/tests/dromaeo/cssquery-yui.html) 12:28:36 INFO - PROCESS | 11533 | RSS: Main: 219406336 12:28:36 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | Cycle 1(1): loaded http://localhost:41149/tests/dromaeo/cssquery-yui.html (next: http://localhost:41149/tests/dromaeo/cssquery-dojo.html) 12:31:39 INFO - PROCESS | 11533 | RSS: Main: 280174592 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | __start_tp_report 12:31:39 INFO - PROCESS | 11533 | _x_x_mozilla_page_load 12:31:39 INFO - PROCESS | 11533 | _x_x_mozilla_page_load_details 12:31:39 INFO - PROCESS | 11533 | |i|pagename|runs| 12:31:39 INFO - PROCESS | 11533 | |0;dojo.html;3075.8462076896158;3110.4245714542826;3113.7664675149363;3145.5124455709374;3163.8892638757648;5287.206918962158;5366.302380690515;5367.46325367463;5466.617336786427;5494.1484069969165;5359.705216213107;5361.5978801589845;5400.405955344909;5460.890782184354;5495.203195536645;4847.587955023827;4877.682950608217;4879.804807807684;4887.437944636359;5010.924836127461;5018.146915024437;5018.473060328668;5021.146405111122;5027.09512287788;5034.496550344955;4837.105135549935;4880.780364883589;4896.363472748555;4943.728094954776;4993.475685053071;4905.2887331337115;4942.87642808929;4946.925796113062;4951.059298733229;5025.949740502621;4900.068986892515;4906.362172917534;4917.50824917509;4923.852284431437;4954.281629163751;5238.73806309683;5421.620486565942;5428.294321738149;5431.429699881495;5439.238506609078;5633.239512665819;5746.683932383718;5803.332616749086;5805.88388232233;5854.20968169296;5841;5847;5852.824415267549;5855.590108692393;5857.4435428634215;5439.782408703647;5440.510354068153;5441.646292990943;5447.346318441772;5447.45525447456;5689.345725241567;5758.193852860519;5829.242198514251;5886.264216972879;5891.322497912709;5632.324121105494;5668.433156684381;5679.914801277984;5680.11958146488;5739.139129130664;5717.828465146053;5763.538916886639;5783.71081445926;5784.768609255582;5785.595008349375;5616.354119276336;5630.521405680481;5691.715414229272;5730.025895597759;5742.397048309867;5735.856603584861;5737.3115226172295;5757.827265182052;5812.82561523155;5821.359650438449;4354.521002689701;4360.629346505519;4361.716488428242;4408.140412619572;4410.823567057282;3840.846366145323;3882.650561449483;3888.8055597220027;3889.7082718796205;3958.5249770027203;5453.291072160594;5486.561075113981;5500.4499550045475;5561.777528898799;5563.8887222256135;5729.8567535811935;5780.075187969905;5784.045632470679;5788.392218817048;5789;5385.9730701347025;5390.811321603725;5487.039768040657;5489.807856724996;5499.780008799603;4916.262560615936;4945.703257804544;4963.776630051656;5005.599552035901;5035.647504674637;5976.163337132892;5979.970100149559;5982;6050.21347224858;6053.4551890330085;5770.682612456355;5771.8557036074435;5775.94224057754;5778.797742079007;5782.681952492485;5898.675572843535;5907.5273978080795;5968.492678122235;5977.731002104829;6032.638041717511;5721.113227449752;5725.971370143289;5731.426857314235;5749.683767392834;5792.594518383673;5783.248177736868;5804.796832110856;5814.73833677494;5817.709114544171;5817.883642327214;5452.672839629635;5534.142207957773;5545.750441230073;5557.555395568425;5582.609217354746;5612.298462692163;5658;5668.206451096932;5737;5739.311282646109;5597.076482380362;5604.635698679573;5606.2431571738925;5608.691521966331;5612.102063669793;5562.415946325577;5600.663960162403;5685.090385538294;5693.800716974886;5694.430556944438;5560.833175004756;5593.776248949996;5610.9158362623775;5632.85917852057;5705.258316418839 12:31:39 INFO - PROCESS | 11533 | |1;ext.html;573.2576313673792;602.3253955569762;617.4103730936951;621.4220774679548;623.1151764494417;32727.181820454472;42282.577174228245;43258.351124733075;43291.567084329145;43347.56652433475;44677.77661111698;45128.54871451284;45169.09661806762;45187.32219016717;45212.32181517272;9030.774230644254;9189.862152067724;9199.356045076847;9203.907960920373;9203.95398023009;9010.459372437643;9109.180173784358;9112.45325280482;9120.726378208665;9120.8631870522;9083.909160908372;9135.908640913573;9142.360034797566;9156.404833685823;9158.954205228965;9084.454932704059;9106.863397048983;9125.680601178994;9132.041135680758;9134.497602631853;8911;9016.323775716848;9045.140711632384;9045.819083618291;9052.637894484213;42043.57956420427;42557.78721106375;42591.57408425907;42593.78703106465;42623;3374.561307030095;3870.767753934773;4052.6960477963976;4088.5707000765087;4190.664746820247;31129.533057004162;31627.36745265082;31919.202019949455;31981.680183198103;32022.679773202435;4169.312063509517;4174.144300418407;4315.590018948226;4457.264551349023;4462.732236065846;338561;340955.9999999975;341481;342856;342871;55800.72099639476;56081.71959140178;56119.71940140273;56122.15816762752;56226.37736226345;58740;58792.41207587955;58893.70553147292;58922.410775891694;58945.873788835226;16471.91764041196;16706.331746730237;16715.414960476326;16715.83284167143;16718.665626687398;12968.935155324352;13031.674208144872;13043.934780326228;13051.934740326427;13052.54316098932;12850.871491285154;16142.273597688132;16230.837691623168;16329.836701632832;16394.83605163957;6316.873662526816;6402.743890244338;6419.679016049179;6439.935600643934;6550.377714117247;901.9503927284062;926.9258459323238;1058.5448257249302;1082.7888561730545;1129.915331145976;30967.013984233396;31286.217844554067;31508;31595.21011974719;32228.35543289121;920.8204400142042;1036.3419228789774;1052.2003277509148;1106.1593189176124;1190.1609365397546;15211.847881521264;16038.919805400898;16142;16242.187890605423;16466.588335291715;512290.2095279942;513163;514211;514233;515511;53900.46099539033;54093.72953135209;54147;54183.72908135513;54215;1188.102982248397;1250.993745031269;1275.4133098774482;1327.482281910056;1353.1813252981804;29180.56229156522;32034.19914502156;32435.02694919156;32526.674733252363;32546.448524341846;46587.76706116448;47084.7645761769;47127.29309060298;47152;47165.29252061291;369736;370531;370837;372363;372435;27048.864755676095;27419.45161096727;27976.300592484535;28113.859430702716;29503.639708822815;46345.76827115843;46460.30309545292;46892.7655361721;47382.76308618435;47633.523664762906;39621.82079985629;39974.20051598894;40844.01431685025;41761.58238417577;42302.576974229865;39255.41116883306;39863.2027359457;40316.59683403128;40771.796141019106;41317;39610.60389396069;39765.80117099396;41262.38106428466;41393;41471.37792933169;33127.503087453224;35617.82191089132;35876.923692289274;36637.26725465422;36731;27826.86086569635;27940.860295698392;28181.859090704416;28200;28329.71670283271 12:31:39 INFO - PROCESS | 11533 | |2;jquery.html;357.973152013599;365.2767520309785;367.6525683229348;375.9079025638719;381.051182555437;14520.854791452082;15268.618284542878;15627.062376257432;18671.253149873988;19421;17863.732044019318;18565;18627.720584191215;19077.236910523563;19175.520611984673;4912.533309335617;5187.507186817246;5189.584833213353;5194.298769666103;5200.713960732158;5155.381354237496;5191.221316802472;5459.781608735666;5708.971455142719;5748.367679555246;5746.913796293059;5793.826185214451;5796.971015144918;5800.15897694834;5801.564882633819;5656.377798442168;5799.681017544033;5806.738696758656;5824.301083869963;5849.239598852165;5671.922334756383;5678.517326027292;5685.545156387479;5686.2039314496005;5686.834198989197;21474.141034358607;22112.557748845094;22265.44336391603;23122.768772312396;23260.767392326197;1901.8573606979533;2250.1561914282142;2284.890799314228;2423.7212720537186;2821.703721109295;9077.273818094536;9395.20140788027;9452.43285402878;11300.265482743594;13662.453501859914;1763.3916298876995;1818.3817502049235;1864.9440516784518;1889.6031833315021;1897.6299621573799;75736.62131689361;75966.6201668988;78336.60831695862;80261;83726.99999999939;9806.852897206547;10143.18854491639;10274.845877311845;10536.10443112344;10619.734506637242;14569;14627.488037918622;14677.119372837451;14718.852811471963;14730.189839558927;7714.228577142241;7832.804179895435;7897.407694422941;7960.243776841191;8040.8793868092025;7555.508891922007;7622.237776222444;7711.807204819812;7790.649420776079;7825.608719563999;4423.159599676052;4485.663575231805;4551.203539380595;4621.260598304255;4649.721016739007;1848.5655870870335;1889.7543319368394;1909.2935613822974;1910.5032691500032;1917.980820191808;401.63451259354434;426.44349124392346;434.54155865561506;434.81954988679973;822.8932086343858;10453.320534165256;10645.946770266099;10931.890681093246;11297.604583839526;11395.430228488542;429.4867633178322;438.53734310302934;449.53473155284127;456.18343165732966;459.7103824590553;5545.611807173459;5878.853028674317;6021.3677563856045;6061.272647282266;6118.174046503665;453639;456302;473160;475142;476760;87382.56308718416;95350.52324738471;95534;96334.51832740931;96346;994.164901482758;1031.0874875735028;1045.29442626227;1095.1622009162998;1097.2209731090854;13185.604431866675;16599.336026559286;16701.99788012723;17728.55678608045;17810.821891780917;31023.53464697986;37957.430638540995;38469.4229586562;40873.795631021654;41268.49429946275;56068.43931560795;56977.430225697215;60383;60420.33790308798;61451.385486146355;5787.305523337226;8254.793630159294;8381.95809020951;8547;8618.35362347839;11629.59296424621;13277.87138093273;13301.201927884358;13303.600891973256;13379.130356526795;11551.133664975328;11558.479868405773;11650.708732281422;11897.345645989553;11924.284542927453;11586.71033224176;11598.478068487108;11619.883801161881;11796.587119450778;12228.266304021787;12002.819957700467;12093.516259349879;12155.392230388623;12205.20666156697;12283.938580307042;8392.87410688828;8530.829383412422;8547.27348175412;8634.654613815628;8691.608877600649;10233.84649230277;12054.698632534257;12281.692957675772;12476.313802740937;12487.063470239587 12:31:39 INFO - PROCESS | 11533 | |3;mootools.html;1408.6890729531697;1453.832809226939;1541.2139808697568;1646.2674110021046;1693.4665580342191;8058.758237252877;8267.503949763019;8742.868856967143;9365.110314520118;9366;8504.787380315494;8738.169873861989;8752.343574231927;8975.910240897589;8992.595333210005;2373.6202207646825;2396.95206095878;2397.1490121007055;2397.8441401308946;2398.3764221302413;2106.3575609439113;2148.355493351996;2370.2533701883935;2401.8678972656585;2451.0563433078305;2316.2356422380576;2372.039324073753;2388.8088952883813;2400.2679182849224;2416.613341865302;2312.5952958232324;2354.411397150712;2366.7396586375485;2377.9286621401384;2383.118246248899;2353.082297903819;2356.8585884846966;2357.446000189954;2367.7987371073477;2388.725296590897;8969.147930946614;9005;9037.231835294007;9039.096090390974;9045.547722613843;5284.471552844723;5339.466053394668;5418.133098704227;5418.620696551243;5428.4028756836715;3342.4317865962844;3511.157322242643;3557.3596752584526;3571.14292569784;3573.5175751273505;1102.3606308341143;1159.8086315757973;1165.7668466306773;1189.6668932698858;1203.1157099531838;11329.263597866195;11330.943345283304;11339.206255562114;11409.714757131054;11433.428328583537;4418.447694038246;4586.197415452282;4694.671373003857;4783.689060211075;4810.95189048112;10213.438260895722;10222.386656800616;10233.43716095607;10256.282060255711;10262.230332724926;5386.165144402624;5389.568834493231;5395.3525576931015;5396.325459317585;5397.10947693634;4918.2376731606655;4974.32846565709;4977.328060711758;4982.402111746614;4995.425526064477;3846.6345697158727;3873.903152421212;3916.9020774480864;3940.2513522430645;3976.642102210757;1117.8379135025539;1138.4478527913955;1178.9941050294694;1179.7758425899224;1197.820326950947;959.6305422412421;962.3456049886145;976.9364991275686;983.3313346924017;998.3211416237028;6183.021433141352;6233.781817636361;6262.624242545462;6310.368963103745;6379.872402551923;964.3439988131123;976.9071938166005;992.8758905136858;1014.6245889020962;1019.8062368150028;4035.3745169498775;4240.109576988867;4242.936355954663;4273.807678654468;4294.441722576107;11179.720506987227;11374.090072794157;11531.827022594667;11543.538258469735;11553.537858485735;11394.202405831513;11403.486843091914;11405.543778248777;11407.885921140849;11412.486438110305;8259.463134896332;8288.58557072144;8360.58197090143;8360.958195209107;8374.539400332918;6034.456898879122;6040.969795150996;6070.210872586712;6164.969175154096;6185.6907154641185;10144.644937427154;10195.847062293924;10216.642417515352;10364.119049880845;10550.419726915094;10527.684169474927;10628.84056739165;10678.359298442118;10723.89276107229;10742.462876855969;7579.2420757925975;7632.1986191451315;7672.271134242238;7687.5387476751575;7691.346235570039;8557.743267701979;8661.437006594551;8735.956320218613;8755.60599772999;8760.12398760119;7732.304092631465;7762.262585054411;7790.571518566533;7807.609619519115;8090.0696419912465;7615.581143037186;7744.883826742491;7759.456838021284;7820.452568320163;7824.334931530883;6476.319986401549;6736.461083113241;7243.130824301117;7297.489175757646;7317.341439270278;5274.180407759317;5324.653897496651;5385.0037743017665;5438.347398312228;5635.577331700057;5429.185622156708;5494.642848214853;5534.1975413565615;5596.272484576979;5616.1856530803625 12:31:39 INFO - PROCESS | 11533 | |4;prototype.html;310.24610197220744;321.30597908517603;327.85410492330925;328.0977312390924;332.187800826978;5055.84832455026;5185.381382401886;5223.6343455958095;5252.921206181905;5271.868203294915;5143.742812859361;5148.2020286855595;5174.146265866128;5190.351206099238;5211.218317252414;4077.8980525486804;4087.386891966214;4093.7543747375103;4118.196951594433;4129.587041295877;3943;4116.650084742801;4141.585841415849;4142.8135733891895;4165.291900376943;4047.433359329696;4053.655439287664;4067.8169482373214;4084.0810817566107;4085.7957102144774;4047.797610119512;4060.3909413587903;4077.694172937027;4077.7553346799286;4093.7339072960162;3588.8743893963588;3595.227026189356;3598.514200582914;3601.9099522511883;3605.1708107135505;4969.310434452267;5089.643724939256;5102.795888164469;5137.766935935349;5156.458571849977;4635.165670179366;4646.303054541812;4660.16117098922;4673.205555055649;4680.531946805327;5436.510714035716;5456.8090116846115;5469.781208751645;5499.835004949858;5509.421510741395;3811.428285757131;3911.198204368098;3924.7448915820664;3933.115049113955;3965.3457179565626;5339.41266460689;5504.394516603171;5638.154276858463;5658.179563963244;5668.518175955049;3887.747296425723;3960.5643379228263;3974.4435778990965;3977.5624681285035;3977.661898738582;3826.196498735241;3919.549251836075;3929.0728407336146;4024.69814763888;4025.6980726445636;4552.226121559343;4562.7262364257585;4575;4583.129205450954;4609.700369476041;5414.91877621836;5416.539594134464;5423.891522169534;5424.728763561806;5429.348478182644;1348.6560926963757;1352.95146261648;1353.6818847570812;1376.6764810269578;1400.103933482572;870.9608067636972;881.1981097201516;885.7785553611598;890.1854802855444;903.2954295649404;4710.610369940876;4711.646626502958;4716.976415117902;4719.693219940693;4731.1720448921305;4921.532454416824;4927.77824997876;4937.506249375106;4948.901021979612;4952.579030782352;4688.765561721901;4706.623470122382;4722.6221902247735;4728.858134255978;4733.928991065068;2754.807163498576;2964.710350997323;2979.554915865803;2994.7422082725307;2996.9700302997126;5833.854153646108;5846.883062338729;5852.092925596539;5863.824085277449;5879.2950044486615;5456.61803673739;5656.604037717402;5699.914501282484;5791.623544469596;5794.246747922743;5782.392848750989;5786.942130578725;5792.9710351447975;5804.970975145097;5816.73824677882;5595.216669666169;5602.747876345493;5604.85987850307;5626.409227031103;5657.773689052557;5320.840374788762;5478.698671573102;5491.615586908878;5501.807436739695;5534.035417426917;5750.396208398225;5764.625299355528;5772.134179873053;5793.652380857162;5844.883102337844;3903.2583809076186;3959.4852669152824;3967.682585393219;4001.8394665546666;4014.9197016060098;5490.752916118704;5496.340439147328;5507.5593952484505;5528.668279903058;5538.972305138448;5342.732863356739;5350.491703288181;5358.678479291255;5395.4604539545735;5400.9459905400445;5325.440828712929;5335.146376579729;5382.623216374973;5404.432534583812;5420.53925416344;5339.813106541253;5342.759575819176;5368.664630885577;5394.221975682605;5409.268319498628;5460.3993560707495;5471.425500322409;5481.972590137183;5516.172574113754;5517.172424136412;5084.440711521655;5306.177542480922;5324.414314425488;5330.493603107699;5398.379186393615 12:31:39 INFO - PROCESS | 11533 | |5;yui.html;743.7843025522598;750.7860259825951;779.1585088104847;782.4483738964024;822.6873787960574;14438.855611443896;15150.54548363548;15232.238388080594;15308;15325.770113448294;13940.651483712913;13950.581482555539;13967.231802250897;13968.580942571714;13977.23125228112;647.7376662451715;662.0301258656068;769.7459838253377;787.5314188058096;791.0902462168524;765.7970637780993;778.5912395992093;790.0322105420871;791.0428381658201;792.1088775127981;826.1820797410551;830.4726498673356;832.1553623072587;832.5837081459271;832.5837081459271;678.5453745990199;826.1036775099025;827.0736774812189;827.1191181391829;828.2587084559316;514.8275327765203;580.2688612348429;597.1490625858135;598.9880202395927;600.9188759517452;14280.214588197645;14314.284285785774;14322.57032289033;14694.779578306334;14705.117692938351;14055.648608784863;14102.858971410256;14606.926965365212;14822;14854.925725371411;12900.677483062998;12912.225266484042;13452.461901523928;13765.311734413239;13805.654858628615;4332.436783218193;4481;4493.146302202571;4624.560666736655;4640.67515273931;78249.60875195645;79184.60407697983;79585;79847;79925.60037199836;11259.831102533468;11332.150088743212;11478.426078696031;11631.6510504685;11964;22152.446188845406;22217.777822221895;22356;22381.44046398853;22402.775972240393;7810.804729881685;7842.294193522496;7976.162502937224;7999.840003199904;8289.461185022954;4399.252127138394;4438.289873620205;4456.398386217819;4471.888202794891;4544.113897789899;3324.069260607034;3418.5214070030215;3446.6897979181995;3449.6205417404067;3455.2225749206227;559.0998492427188;562.7073921560766;579.3308728418683;583.3990989281048;591.382005803936;576.9620917102542;578.3724658745308;616.4144063139945;623.8596315828902;685.2804555217002;8952.731418057469;9253.768655783659;9360.90639093614;9512.476813775309;10061.39631622105;633.4805459523238;634.4044727510316;670.778643047793;681.5637991685326;704.4681265644406;4320.546342633978;4521.773911304422;4603.631709463235;4649.5350464953235;4691.554302341272;115236;119455;119935.81027035632;125736;125949;105344.47327763465;107699;108382.45808770906;110443;112199;93234.53382733042;94829.5258523703;95365.52317238369;96229.5188524053;98609.50695246478;8627.16091339348;8735.301175905784;8817.823643527221;8984.640614375352;9018.954905225432;51959;52463.47536524586;53221.46778532165;53486.465135348146;55134.172987406026;71353;73097.26902730904;78621;79570;81111.56665300051;12074.39628018613;12088.335141566946;12274.631761047183;12301.138920275494;12405.62783116508;12665.430055647334;12943.158694684815;13027.413766380725;13074.150180238254;13592.796108058585;12602.180858244184;12768.170068945488;12860.935695321463;13118.699414317165;13259.138156019828;12169.634910952685;13135.540256091374;13276.137051091648;13282.136661116996;13284.26936518462;11822.704432389259;12072.3360215189;12322.075844311534;12437.253764774143;12802.67993300175;9767.267454940766;10427.113695335982;10516.57933682644;10693.09108725767;10843.620473283398;8706.347023973354;9075.183233509017;9198.540072996457;9273.30450216223;9696.466694331879 12:31:39 INFO - PROCESS | 11533 | __end_tp_report 12:31:39 INFO - PROCESS | 11533 | __start_cc_report 12:31:39 INFO - PROCESS | 11533 | _x_x_mozilla_cycle_collect,1122 12:31:39 INFO - PROCESS | 11533 | __end_cc_report 12:31:39 INFO - PROCESS | 11533 | __startTimestamp1475091099876__endTimestamp 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | ------- Summary: start ------- 12:31:39 INFO - PROCESS | 11533 | Number of tests: 6 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#0] dojo.html Cycles:165 Average:5369.05 Median:5593.78 stddev:610.72 (10.9%) stddev-sans-first:585.50 12:31:39 INFO - PROCESS | 11533 | Values: 3075.8 3110.4 3113.8 3145.5 3163.9 5287.2 5366.3 5367.5 5466.6 5494.1 5359.7 5361.6 5400.4 5460.9 5495.2 4847.6 4877.7 4879.8 4887.4 5010.9 5018.1 5018.5 5021.1 5027.1 5034.5 4837.1 4880.8 4896.4 4943.7 4993.5 4905.3 4942.9 4946.9 4951.1 5025.9 4900.1 4906.4 4917.5 4923.9 4954.3 5238.7 5421.6 5428.3 5431.4 5439.2 5633.2 5746.7 5803.3 5805.9 5854.2 5841.0 5847.0 5852.8 5855.6 5857.4 5439.8 5440.5 5441.6 5447.3 5447.5 5689.3 5758.2 5829.2 5886.3 5891.3 5632.3 5668.4 5679.9 5680.1 5739.1 5717.8 5763.5 5783.7 5784.8 5785.6 5616.4 5630.5 5691.7 5730.0 5742.4 5735.9 5737.3 5757.8 5812.8 5821.4 4354.5 4360.6 4361.7 4408.1 4410.8 3840.8 3882.7 3888.8 3889.7 3958.5 5453.3 5486.6 5500.4 5561.8 5563.9 5729.9 5780.1 5784.0 5788.4 5789.0 5386.0 5390.8 5487.0 5489.8 5499.8 4916.3 4945.7 4963.8 5005.6 5035.6 5976.2 5980.0 5982.0 6050.2 6053.5 5770.7 5771.9 5775.9 5778.8 5782.7 5898.7 5907.5 5968.5 5977.7 6032.6 5721.1 5726.0 5731.4 5749.7 5792.6 5783.2 5804.8 5814.7 5817.7 5817.9 5452.7 5534.1 5545.8 5557.6 5582.6 5612.3 5658.0 5668.2 5737.0 5739.3 5597.1 5604.6 5606.2 5608.7 5612.1 5562.4 5600.7 5685.1 5693.8 5694.4 5560.8 5593.8 5610.9 5632.9 5705.3 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#1] ext.html Cycles:180 Average:57000.45 Median:4171.73 stddev:109995.22 (2636.7%) stddev-sans-first:110222.20 12:31:39 INFO - PROCESS | 11533 | Values: 573.3 602.3 617.4 621.4 623.1 32727.2 42282.6 43258.4 43291.6 43347.6 44677.8 45128.5 45169.1 45187.3 45212.3 9030.8 9189.9 9199.4 9203.9 9204.0 9010.5 9109.2 9112.5 9120.7 9120.9 9083.9 9135.9 9142.4 9156.4 9159.0 9084.5 9106.9 9125.7 9132.0 9134.5 8911.0 9016.3 9045.1 9045.8 9052.6 42043.6 42557.8 42591.6 42593.8 42623.0 3374.6 3870.8 4052.7 4088.6 4190.7 31129.5 31627.4 31919.2 31981.7 32022.7 4169.3 4174.1 4315.6 4457.3 4462.7 338561.0 340956.0 341481.0 342856.0 342871.0 55800.7 56081.7 56119.7 56122.2 56226.4 58740.0 58792.4 58893.7 58922.4 58945.9 16471.9 16706.3 16715.4 16715.8 16718.7 12968.9 13031.7 13043.9 13051.9 13052.5 12850.9 16142.3 16230.8 16329.8 16394.8 6316.9 6402.7 6419.7 6439.9 6550.4 902.0 926.9 1058.5 1082.8 1129.9 30967.0 31286.2 31508.0 31595.2 32228.4 920.8 1036.3 1052.2 1106.2 1190.2 15211.8 16038.9 16142.0 16242.2 16466.6 512290.2 513163.0 514211.0 514233.0 515511.0 53900.5 54093.7 54147.0 54183.7 54215.0 1188.1 1251.0 1275.4 1327.5 1353.2 29180.6 32034.2 32435.0 32526.7 32546.4 46587.8 47084.8 47127.3 47152.0 47165.3 369736.0 370531.0 370837.0 372363.0 372435.0 27048.9 27419.5 27976.3 28113.9 29503.6 46345.8 46460.3 46892.8 47382.8 47633.5 39621.8 39974.2 40844.0 41761.6 42302.6 39255.4 39863.2 40316.6 40771.8 41317.0 39610.6 39765.8 41262.4 41393.0 41471.4 33127.5 35617.8 35876.9 36637.3 36731.0 27826.9 27940.9 28181.9 28200.0 28329.7 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#2] jquery.html Cycles:180 Average:27694.61 Median:20847.47 stddev:77280.06 (370.7%) stddev-sans-first:77469.59 12:31:39 INFO - PROCESS | 11533 | Values: 358.0 365.3 367.7 375.9 381.1 14520.9 15268.6 15627.1 18671.3 19421.0 17863.7 18565.0 18627.7 19077.2 19175.5 4912.5 5187.5 5189.6 5194.3 5200.7 5155.4 5191.2 5459.8 5709.0 5748.4 5746.9 5793.8 5797.0 5800.2 5801.6 5656.4 5799.7 5806.7 5824.3 5849.2 5671.9 5678.5 5685.5 5686.2 5686.8 21474.1 22112.6 22265.4 23122.8 23260.8 1901.9 2250.2 2284.9 2423.7 2821.7 9077.3 9395.2 9452.4 11300.3 13662.5 1763.4 1818.4 1864.9 1889.6 1897.6 75736.6 75966.6 78336.6 80261.0 83727.0 9806.9 10143.2 10274.8 10536.1 10619.7 14569.0 14627.5 14677.1 14718.9 14730.2 7714.2 7832.8 7897.4 7960.2 8040.9 7555.5 7622.2 7711.8 7790.6 7825.6 4423.2 4485.7 4551.2 4621.3 4649.7 1848.6 1889.8 1909.3 1910.5 1918.0 401.6 426.4 434.5 434.8 822.9 10453.3 10645.9 10931.9 11297.6 11395.4 429.5 438.5 449.5 456.2 459.7 5545.6 5878.9 6021.4 6061.3 6118.2 453639.0 456302.0 473160.0 475142.0 476760.0 87382.6 95350.5 95534.0 96334.5 96346.0 994.2 1031.1 1045.3 1095.2 1097.2 13185.6 16599.3 16702.0 17728.6 17810.8 31023.5 37957.4 38469.4 40873.8 41268.5 56068.4 56977.4 60383.0 60420.3 61451.4 5787.3 8254.8 8382.0 8547.0 8618.4 11629.6 13277.9 13301.2 13303.6 13379.1 11551.1 11558.5 11650.7 11897.3 11924.3 11586.7 11598.5 11619.9 11796.6 12228.3 12002.8 12093.5 12155.4 12205.2 12283.9 8392.9 8530.8 8547.3 8634.7 8691.6 10233.8 12054.7 12281.7 12476.3 12487.1 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#3] mootools.html Cycles:180 Average:5895.74 Median:4797.32 stddev:3319.96 (69.2%) stddev-sans-first:3312.15 12:31:39 INFO - PROCESS | 11533 | Values: 1408.7 1453.8 1541.2 1646.3 1693.5 8058.8 8267.5 8742.9 9365.1 9366.0 8504.8 8738.2 8752.3 8975.9 8992.6 2373.6 2397.0 2397.1 2397.8 2398.4 2106.4 2148.4 2370.3 2401.9 2451.1 2316.2 2372.0 2388.8 2400.3 2416.6 2312.6 2354.4 2366.7 2377.9 2383.1 2353.1 2356.9 2357.4 2367.8 2388.7 8969.1 9005.0 9037.2 9039.1 9045.5 5284.5 5339.5 5418.1 5418.6 5428.4 3342.4 3511.2 3557.4 3571.1 3573.5 1102.4 1159.8 1165.8 1189.7 1203.1 11329.3 11330.9 11339.2 11409.7 11433.4 4418.4 4586.2 4694.7 4783.7 4811.0 10213.4 10222.4 10233.4 10256.3 10262.2 5386.2 5389.6 5395.4 5396.3 5397.1 4918.2 4974.3 4977.3 4982.4 4995.4 3846.6 3873.9 3916.9 3940.3 3976.6 1117.8 1138.4 1179.0 1179.8 1197.8 959.6 962.3 976.9 983.3 998.3 6183.0 6233.8 6262.6 6310.4 6379.9 964.3 976.9 992.9 1014.6 1019.8 4035.4 4240.1 4242.9 4273.8 4294.4 11179.7 11374.1 11531.8 11543.5 11553.5 11394.2 11403.5 11405.5 11407.9 11412.5 8259.5 8288.6 8360.6 8361.0 8374.5 6034.5 6041.0 6070.2 6165.0 6185.7 10144.6 10195.8 10216.6 10364.1 10550.4 10527.7 10628.8 10678.4 10723.9 10742.5 7579.2 7632.2 7672.3 7687.5 7691.3 8557.7 8661.4 8736.0 8755.6 8760.1 7732.3 7762.3 7790.6 7807.6 8090.1 7615.6 7744.9 7759.5 7820.5 7824.3 6476.3 6736.5 7243.1 7297.5 7317.3 5274.2 5324.7 5385.0 5438.3 5635.6 5429.2 5494.6 5534.2 5596.3 5616.2 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#4] prototype.html Cycles:180 Average:4537.98 Median:5140.75 stddev:1334.09 (26.0%) stddev-sans-first:1299.54 12:31:39 INFO - PROCESS | 11533 | Values: 310.2 321.3 327.9 328.1 332.2 5055.8 5185.4 5223.6 5252.9 5271.9 5143.7 5148.2 5174.1 5190.4 5211.2 4077.9 4087.4 4093.8 4118.2 4129.6 3943.0 4116.7 4141.6 4142.8 4165.3 4047.4 4053.7 4067.8 4084.1 4085.8 4047.8 4060.4 4077.7 4077.8 4093.7 3588.9 3595.2 3598.5 3601.9 3605.2 4969.3 5089.6 5102.8 5137.8 5156.5 4635.2 4646.3 4660.2 4673.2 4680.5 5436.5 5456.8 5469.8 5499.8 5509.4 3811.4 3911.2 3924.7 3933.1 3965.3 5339.4 5504.4 5638.2 5658.2 5668.5 3887.7 3960.6 3974.4 3977.6 3977.7 3826.2 3919.5 3929.1 4024.7 4025.7 4552.2 4562.7 4575.0 4583.1 4609.7 5414.9 5416.5 5423.9 5424.7 5429.3 1348.7 1353.0 1353.7 1376.7 1400.1 871.0 881.2 885.8 890.2 903.3 4710.6 4711.6 4717.0 4719.7 4731.2 4921.5 4927.8 4937.5 4948.9 4952.6 4688.8 4706.6 4722.6 4728.9 4733.9 2754.8 2964.7 2979.6 2994.7 2997.0 5833.9 5846.9 5852.1 5863.8 5879.3 5456.6 5656.6 5699.9 5791.6 5794.2 5782.4 5786.9 5793.0 5805.0 5816.7 5595.2 5602.7 5604.9 5626.4 5657.8 5320.8 5478.7 5491.6 5501.8 5534.0 5750.4 5764.6 5772.1 5793.7 5844.9 3903.3 3959.5 3967.7 4001.8 4014.9 5490.8 5496.3 5507.6 5528.7 5539.0 5342.7 5350.5 5358.7 5395.5 5400.9 5325.4 5335.1 5382.6 5404.4 5420.5 5339.8 5342.8 5368.7 5394.2 5409.3 5460.4 5471.4 5482.0 5516.2 5517.2 5084.4 5306.2 5324.4 5330.5 5398.4 12:31:39 INFO - PROCESS | 11533 | 12:31:39 INFO - PROCESS | 11533 | [#5] yui.html Cycles:180 Average:21472.91 Median:4614.10 stddev:32201.84 (697.9%) stddev-sans-first:32254.56 12:31:39 INFO - PROCESS | 11533 | Values: 743.8 750.8 779.2 782.4 822.7 14438.9 15150.5 15232.2 15308.0 15325.8 13940.7 13950.6 13967.2 13968.6 13977.2 647.7 662.0 769.7 787.5 791.1 765.8 778.6 790.0 791.0 792.1 826.2 830.5 832.2 832.6 832.6 678.5 826.1 827.1 827.1 828.3 514.8 580.3 597.1 599.0 600.9 14280.2 14314.3 14322.6 14694.8 14705.1 14055.6 14102.9 14606.9 14822.0 14854.9 12900.7 12912.2 13452.5 13765.3 13805.7 4332.4 4481.0 4493.1 4624.6 4640.7 78249.6 79184.6 79585.0 79847.0 79925.6 11259.8 11332.2 11478.4 11631.7 11964.0 22152.4 22217.8 22356.0 22381.4 22402.8 7810.8 7842.3 7976.2 7999.8 8289.5 4399.3 4438.3 4456.4 4471.9 4544.1 3324.1 3418.5 3446.7 3449.6 3455.2 559.1 562.7 579.3 583.4 591.4 577.0 578.4 616.4 623.9 685.3 8952.7 9253.8 9360.9 9512.5 10061.4 633.5 634.4 670.8 681.6 704.5 4320.5 4521.8 4603.6 4649.5 4691.6 115236.0 119455.0 119935.8 125736.0 125949.0 105344.5 107699.0 108382.5 110443.0 112199.0 93234.5 94829.5 95365.5 96229.5 98609.5 8627.2 8735.3 8817.8 8984.6 9019.0 51959.0 52463.5 53221.5 53486.5 55134.2 71353.0 73097.3 78621.0 79570.0 81111.6 12074.4 12088.3 12274.6 12301.1 12405.6 12665.4 12943.2 13027.4 13074.2 13592.8 12602.2 12768.2 12860.9 13118.7 13259.1 12169.6 13135.5 13276.1 13282.1 13284.3 11822.7 12072.3 12322.1 12437.3 12802.7 9767.3 10427.1 10516.6 10693.1 10843.6 8706.3 9075.2 9198.5 9273.3 9696.5 12:31:39 INFO - PROCESS | 11533 | -------- Summary: end -------- 12:31:39 INFO - PROCESS | 11533 | 12:31:40 INFO - TEST-INFO | 11533: exit 0 12:31:40 INFO - TEST-OK | dromaeo_css | took 1116243ms 12:31:40 INFO - TEST-START | kraken 12:31:40 INFO - operating with platform_type : linux_ 12:31:40 INFO - Initialising browser for kraken test... 12:31:40 INFO - TEST-INFO | started process 11850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKdhGM/profile http://localhost:41149/getInfo.html) 12:31:45 INFO - PROCESS | 11850 | __metrics Screen width/height:1600/1200 12:31:45 INFO - PROCESS | 11850 | colorDepth:24 12:31:45 INFO - PROCESS | 11850 | Browser inner width/height: 1024/697 12:31:45 INFO - PROCESS | 11850 | __metrics 12:31:45 INFO - PROCESS | 11850 | 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" 12:31:45 INFO - PROCESS | 11850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:31:46 INFO - PROCESS | 11850 | console.error: PushService: 12:31:46 INFO - PROCESS | 11850 | stateChangeProcessEnqueue: Error transitioning state 12:31:46 INFO - PROCESS | 11850 | UnknownError 12:31:46 INFO - TEST-INFO | 11850: exit 0 12:31:46 INFO - Browser initialized. 12:31:46 INFO - Running cycle 1/1 for kraken test... 12:31:46 INFO - TEST-INFO | started process 11934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKdhGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:58 INFO - PROCESS | 11934 | RSS: Main: 173367296 12:31:58 INFO - PROCESS | 11934 | 12:32:01 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41149/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:02 INFO - PROCESS | 11934 | RSS: Main: 241500160 12:32:02 INFO - PROCESS | 11934 | 12:32:04 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41149/tests/kraken/driver.html?testName=audio-dft) 12:32:05 INFO - PROCESS | 11934 | RSS: Main: 217137152 12:32:05 INFO - PROCESS | 11934 | 12:32:08 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41149/tests/kraken/driver.html?testName=audio-fft) 12:32:09 INFO - PROCESS | 11934 | RSS: Main: 298221568 12:32:09 INFO - PROCESS | 11934 | 12:32:11 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41149/tests/kraken/driver.html?testName=audio-oscillator) 12:32:11 INFO - PROCESS | 11934 | RSS: Main: 207937536 12:32:11 INFO - PROCESS | 11934 | 12:32:14 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:32:14 INFO - PROCESS | 11934 | RSS: Main: 212787200 12:32:14 INFO - PROCESS | 11934 | 12:32:17 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41149/tests/kraken/driver.html?testName=imaging-darkroom) 12:32:18 INFO - PROCESS | 11934 | RSS: Main: 249495552 12:32:18 INFO - PROCESS | 11934 | 12:32:21 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41149/tests/kraken/driver.html?testName=imaging-desaturate) 12:32:22 INFO - PROCESS | 11934 | RSS: Main: 248700928 12:32:22 INFO - PROCESS | 11934 | 12:32:24 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41149/tests/kraken/driver.html?testName=json-parse-financial) 12:32:25 INFO - PROCESS | 11934 | RSS: Main: 248479744 12:32:25 INFO - PROCESS | 11934 | 12:32:26 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:32:27 INFO - PROCESS | 11934 | RSS: Main: 209760256 12:32:27 INFO - PROCESS | 11934 | 12:32:29 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:32:29 INFO - PROCESS | 11934 | RSS: Main: 217460736 12:32:29 INFO - PROCESS | 11934 | 12:32:31 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:32:32 INFO - PROCESS | 11934 | RSS: Main: 221868032 12:32:32 INFO - PROCESS | 11934 | 12:32:35 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:32:35 INFO - PROCESS | 11934 | RSS: Main: 222994432 12:32:35 INFO - PROCESS | 11934 | 12:32:38 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:32:39 INFO - PROCESS | 11934 | RSS: Main: 221614080 12:32:39 INFO - PROCESS | 11934 | 12:32:40 INFO - PROCESS | 11934 | Cycle 1(1): loaded http://localhost:41149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41149/tests/kraken/driver.html?testName=ai-astar) 12:32:41 INFO - PROCESS | 11934 | RSS: Main: 271998976 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | __start_tp_report 12:32:41 INFO - PROCESS | 11934 | _x_x_mozilla_page_load 12:32:41 INFO - PROCESS | 11934 | _x_x_mozilla_page_load_details 12:32:41 INFO - PROCESS | 11934 | |i|pagename|runs| 12:32:41 INFO - PROCESS | 11934 | |0;ai-astar;110;111;111;111;111;110;112;110;110;111 12:32:41 INFO - PROCESS | 11934 | |1;audio-beat-detection;144;118;121;155;122;123;118;120;162;118 12:32:41 INFO - PROCESS | 11934 | |2;audio-dft;161;161;162;161;160;160;161;162;162;161 12:32:41 INFO - PROCESS | 11934 | |3;audio-fft;76;76;75;117;76;76;77;76;105;78 12:32:41 INFO - PROCESS | 11934 | |4;audio-oscillator;84;83;113;82;82;82;102;82;82;107 12:32:41 INFO - PROCESS | 11934 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;116;117;117 12:32:41 INFO - PROCESS | 11934 | |6;imaging-darkroom;146;145;145;145;146;146;147;148;147;147 12:32:41 INFO - PROCESS | 11934 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 12:32:41 INFO - PROCESS | 11934 | |8;json-parse-financial;49;51;49;51;50;53;50;51;51;51 12:32:41 INFO - PROCESS | 11934 | |9;json-stringify-tinderbox;59;61;60;59;59;59;59;59;59;60 12:32:41 INFO - PROCESS | 11934 | |10;stanford-crypto-aes;80;79;79;77;78;81;79;78;78;79 12:32:41 INFO - PROCESS | 11934 | |11;stanford-crypto-ccm;126;130;138;123;123;125;130;129;163;125 12:32:41 INFO - PROCESS | 11934 | |12;stanford-crypto-pbkdf2;161;164;164;165;174;164;163;166;166;163 12:32:41 INFO - PROCESS | 11934 | |13;stanford-crypto-sha256-iterative;64;64;66;67;70;66;63;65;63;64 12:32:41 INFO - PROCESS | 11934 | __end_tp_report 12:32:41 INFO - PROCESS | 11934 | __start_cc_report 12:32:41 INFO - PROCESS | 11934 | _x_x_mozilla_cycle_collect,1624 12:32:41 INFO - PROCESS | 11934 | __end_cc_report 12:32:41 INFO - PROCESS | 11934 | __startTimestamp1475091161074__endTimestamp 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | ------- Summary: start ------- 12:32:41 INFO - PROCESS | 11934 | Number of tests: 14 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:32:41 INFO - PROCESS | 11934 | Values: 110.0 111.0 111.0 111.0 111.0 110.0 112.0 110.0 110.0 111.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:122.50 stddev:16.90 (13.8%) stddev-sans-first:17.16 12:32:41 INFO - PROCESS | 11934 | Values: 144.0 118.0 121.0 155.0 122.0 123.0 118.0 120.0 162.0 118.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 12:32:41 INFO - PROCESS | 11934 | Values: 161.0 161.0 162.0 161.0 160.0 160.0 161.0 162.0 162.0 161.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:14.94 (19.7%) stddev-sans-first:15.62 12:32:41 INFO - PROCESS | 11934 | Values: 76.0 76.0 75.0 117.0 76.0 76.0 77.0 76.0 105.0 78.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:12.32 (15.0%) stddev-sans-first:12.89 12:32:41 INFO - PROCESS | 11934 | Values: 84.0 83.0 113.0 82.0 82.0 82.0 102.0 82.0 82.0 107.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:32:41 INFO - PROCESS | 11934 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 12:32:41 INFO - PROCESS | 11934 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 147.0 148.0 147.0 147.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:32:41 INFO - PROCESS | 11934 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.17 (2.3%) stddev-sans-first:1.09 12:32:41 INFO - PROCESS | 11934 | Values: 49.0 51.0 49.0 51.0 50.0 53.0 50.0 51.0 51.0 51.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 12:32:41 INFO - PROCESS | 11934 | Values: 59.0 61.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 12:32:41 INFO - PROCESS | 11934 | Values: 80.0 79.0 79.0 77.0 78.0 81.0 79.0 78.0 78.0 79.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.50 stddev:12.04 (9.3%) stddev-sans-first:12.62 12:32:41 INFO - PROCESS | 11934 | Values: 126.0 130.0 138.0 123.0 123.0 125.0 130.0 129.0 163.0 125.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:164.50 stddev:3.50 (2.1%) stddev-sans-first:3.40 12:32:41 INFO - PROCESS | 11934 | Values: 161.0 164.0 164.0 165.0 174.0 164.0 163.0 166.0 166.0 163.0 12:32:41 INFO - PROCESS | 11934 | 12:32:41 INFO - PROCESS | 11934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:2.15 (3.3%) stddev-sans-first:2.24 12:32:41 INFO - PROCESS | 11934 | Values: 64.0 64.0 66.0 67.0 70.0 66.0 63.0 65.0 63.0 64.0 12:32:41 INFO - PROCESS | 11934 | -------- Summary: end -------- 12:32:41 INFO - PROCESS | 11934 | 12:32:42 INFO - TEST-INFO | 11934: exit 0 12:32:42 INFO - TEST-OK | kraken | took 61536ms 12:32:42 INFO - SUITE-END | took 1177s 12:32:42 INFO - Completed test suite (00:19:38) 12:32:42 INFO - javascript benchmark 12:32:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.8462076896158, 3110.4245714542826, 3113.7664675149363, 3145.5124455709374, 3163.8892638757648, 5287.206918962158, 5366.302380690515, 5367.46325367463, 5466.617336786427, 5494.1484069969165, 5359.705216213107, 5361.5978801589845, 5400.405955344909, 5460.890782184354, 5495.203195536645, 4847.587955023827, 4877.682950608217, 4879.804807807684, 4887.437944636359, 5010.924836127461, 5018.146915024437, 5018.473060328668, 5021.146405111122, 5027.09512287788, 5034.496550344955, 4837.105135549935, 4880.780364883589, 4896.363472748555, 4943.728094954776, 4993.475685053071, 4905.2887331337115, 4942.87642808929, 4946.925796113062, 4951.059298733229, 5025.949740502621, 4900.068986892515, 4906.362172917534, 4917.50824917509, 4923.852284431437, 4954.281629163751, 5238.73806309683, 5421.620486565942, 5428.294321738149, 5431.429699881495, 5439.238506609078, 5633.239512665819, 5746.683932383718, 5803.332616749086, 5805.88388232233, 5854.20968169296, 5841.0, 5847.0, 5852.824415267549, 5855.590108692393, 5857.4435428634215, 5439.782408703647, 5440.510354068153, 5441.646292990943, 5447.346318441772, 5447.45525447456, 5689.345725241567, 5758.193852860519, 5829.242198514251, 5886.264216972879, 5891.322497912709, 5632.324121105494, 5668.433156684381, 5679.914801277984, 5680.11958146488, 5739.139129130664, 5717.828465146053, 5763.538916886639, 5783.71081445926, 5784.768609255582, 5785.595008349375, 5616.354119276336, 5630.521405680481, 5691.715414229272, 5730.025895597759, 5742.397048309867, 5735.856603584861, 5737.3115226172295, 5757.827265182052, 5812.82561523155, 5821.359650438449, 4354.521002689701, 4360.629346505519, 4361.716488428242, 4408.140412619572, 4410.823567057282, 3840.846366145323, 3882.650561449483, 3888.8055597220027, 3889.7082718796205, 3958.5249770027203, 5453.291072160594, 5486.561075113981, 5500.4499550045475, 5561.777528898799, 5563.8887222256135, 5729.8567535811935, 5780.075187969905, 5784.045632470679, 5788.392218817048, 5789.0, 5385.9730701347025, 5390.811321603725, 5487.039768040657, 5489.807856724996, 5499.780008799603, 4916.262560615936, 4945.703257804544, 4963.776630051656, 5005.599552035901, 5035.647504674637, 5976.163337132892, 5979.970100149559, 5982.0, 6050.21347224858, 6053.4551890330085, 5770.682612456355, 5771.8557036074435, 5775.94224057754, 5778.797742079007, 5782.681952492485, 5898.675572843535, 5907.5273978080795, 5968.492678122235, 5977.731002104829, 6032.638041717511, 5721.113227449752, 5725.971370143289, 5731.426857314235, 5749.683767392834, 5792.594518383673, 5783.248177736868, 5804.796832110856, 5814.73833677494, 5817.709114544171, 5817.883642327214, 5452.672839629635, 5534.142207957773, 5545.750441230073, 5557.555395568425, 5582.609217354746, 5612.298462692163, 5658.0, 5668.206451096932, 5737.0, 5739.311282646109, 5597.076482380362, 5604.635698679573, 5606.2431571738925, 5608.691521966331, 5612.102063669793, 5562.415946325577, 5600.663960162403, 5685.090385538294, 5693.800716974886, 5694.430556944438, 5560.833175004756, 5593.776248949996, 5610.9158362623775, 5632.85917852057, 5705.258316418839], "value": 5327.430606244855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2576313673792, 602.3253955569762, 617.4103730936951, 621.4220774679548, 623.1151764494417, 32727.181820454472, 42282.577174228245, 43258.351124733075, 43291.567084329145, 43347.56652433475, 44677.77661111698, 45128.54871451284, 45169.09661806762, 45187.32219016717, 45212.32181517272, 9030.774230644254, 9189.862152067724, 9199.356045076847, 9203.907960920373, 9203.95398023009, 9010.459372437643, 9109.180173784358, 9112.45325280482, 9120.726378208665, 9120.8631870522, 9083.909160908372, 9135.908640913573, 9142.360034797566, 9156.404833685823, 9158.954205228965, 9084.454932704059, 9106.863397048983, 9125.680601178994, 9132.041135680758, 9134.497602631853, 8911.0, 9016.323775716848, 9045.140711632384, 9045.819083618291, 9052.637894484213, 42043.57956420427, 42557.78721106375, 42591.57408425907, 42593.78703106465, 42623.0, 3374.561307030095, 3870.767753934773, 4052.6960477963976, 4088.5707000765087, 4190.664746820247, 31129.533057004162, 31627.36745265082, 31919.202019949455, 31981.680183198103, 32022.679773202435, 4169.312063509517, 4174.144300418407, 4315.590018948226, 4457.264551349023, 4462.732236065846, 338561.0, 340955.9999999975, 341481.0, 342856.0, 342871.0, 55800.72099639476, 56081.71959140178, 56119.71940140273, 56122.15816762752, 56226.37736226345, 58740.0, 58792.41207587955, 58893.70553147292, 58922.410775891694, 58945.873788835226, 16471.91764041196, 16706.331746730237, 16715.414960476326, 16715.83284167143, 16718.665626687398, 12968.935155324352, 13031.674208144872, 13043.934780326228, 13051.934740326427, 13052.54316098932, 12850.871491285154, 16142.273597688132, 16230.837691623168, 16329.836701632832, 16394.83605163957, 6316.873662526816, 6402.743890244338, 6419.679016049179, 6439.935600643934, 6550.377714117247, 901.9503927284062, 926.9258459323238, 1058.5448257249302, 1082.7888561730545, 1129.915331145976, 30967.013984233396, 31286.217844554067, 31508.0, 31595.21011974719, 32228.35543289121, 920.8204400142042, 1036.3419228789774, 1052.2003277509148, 1106.1593189176124, 1190.1609365397546, 15211.847881521264, 16038.919805400898, 16142.0, 16242.187890605423, 16466.588335291715, 512290.2095279942, 513163.0, 514211.0, 514233.0, 515511.0, 53900.46099539033, 54093.72953135209, 54147.0, 54183.72908135513, 54215.0, 1188.102982248397, 1250.993745031269, 1275.4133098774482, 1327.482281910056, 1353.1813252981804, 29180.56229156522, 32034.19914502156, 32435.02694919156, 32526.674733252363, 32546.448524341846, 46587.76706116448, 47084.7645761769, 47127.29309060298, 47152.0, 47165.29252061291, 369736.0, 370531.0, 370837.0, 372363.0, 372435.0, 27048.864755676095, 27419.45161096727, 27976.300592484535, 28113.859430702716, 29503.639708822815, 46345.76827115843, 46460.30309545292, 46892.7655361721, 47382.76308618435, 47633.523664762906, 39621.82079985629, 39974.20051598894, 40844.01431685025, 41761.58238417577, 42302.576974229865, 39255.41116883306, 39863.2027359457, 40316.59683403128, 40771.796141019106, 41317.0, 39610.60389396069, 39765.80117099396, 41262.38106428466, 41393.0, 41471.37792933169, 33127.503087453224, 35617.82191089132, 35876.923692289274, 36637.26725465422, 36731.0, 27826.86086569635, 27940.860295698392, 28181.859090704416, 28200.0, 28329.71670283271], "value": 19665.229403150657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.973152013599, 365.2767520309785, 367.6525683229348, 375.9079025638719, 381.051182555437, 14520.854791452082, 15268.618284542878, 15627.062376257432, 18671.253149873988, 19421.0, 17863.732044019318, 18565.0, 18627.720584191215, 19077.236910523563, 19175.520611984673, 4912.533309335617, 5187.507186817246, 5189.584833213353, 5194.298769666103, 5200.713960732158, 5155.381354237496, 5191.221316802472, 5459.781608735666, 5708.971455142719, 5748.367679555246, 5746.913796293059, 5793.826185214451, 5796.971015144918, 5800.15897694834, 5801.564882633819, 5656.377798442168, 5799.681017544033, 5806.738696758656, 5824.301083869963, 5849.239598852165, 5671.922334756383, 5678.517326027292, 5685.545156387479, 5686.2039314496005, 5686.834198989197, 21474.141034358607, 22112.557748845094, 22265.44336391603, 23122.768772312396, 23260.767392326197, 1901.8573606979533, 2250.1561914282142, 2284.890799314228, 2423.7212720537186, 2821.703721109295, 9077.273818094536, 9395.20140788027, 9452.43285402878, 11300.265482743594, 13662.453501859914, 1763.3916298876995, 1818.3817502049235, 1864.9440516784518, 1889.6031833315021, 1897.6299621573799, 75736.62131689361, 75966.6201668988, 78336.60831695862, 80261.0, 83726.99999999939, 9806.852897206547, 10143.18854491639, 10274.845877311845, 10536.10443112344, 10619.734506637242, 14569.0, 14627.488037918622, 14677.119372837451, 14718.852811471963, 14730.189839558927, 7714.228577142241, 7832.804179895435, 7897.407694422941, 7960.243776841191, 8040.8793868092025, 7555.508891922007, 7622.237776222444, 7711.807204819812, 7790.649420776079, 7825.608719563999, 4423.159599676052, 4485.663575231805, 4551.203539380595, 4621.260598304255, 4649.721016739007, 1848.5655870870335, 1889.7543319368394, 1909.2935613822974, 1910.5032691500032, 1917.980820191808, 401.63451259354434, 426.44349124392346, 434.54155865561506, 434.81954988679973, 822.8932086343858, 10453.320534165256, 10645.946770266099, 10931.890681093246, 11297.604583839526, 11395.430228488542, 429.4867633178322, 438.53734310302934, 449.53473155284127, 456.18343165732966, 459.7103824590553, 5545.611807173459, 5878.853028674317, 6021.3677563856045, 6061.272647282266, 6118.174046503665, 453639.0, 456302.0, 473160.0, 475142.0, 476760.0, 87382.56308718416, 95350.52324738471, 95534.0, 96334.51832740931, 96346.0, 994.164901482758, 1031.0874875735028, 1045.29442626227, 1095.1622009162998, 1097.2209731090854, 13185.604431866675, 16599.336026559286, 16701.99788012723, 17728.55678608045, 17810.821891780917, 31023.53464697986, 37957.430638540995, 38469.4229586562, 40873.795631021654, 41268.49429946275, 56068.43931560795, 56977.430225697215, 60383.0, 60420.33790308798, 61451.385486146355, 5787.305523337226, 8254.793630159294, 8381.95809020951, 8547.0, 8618.35362347839, 11629.59296424621, 13277.87138093273, 13301.201927884358, 13303.600891973256, 13379.130356526795, 11551.133664975328, 11558.479868405773, 11650.708732281422, 11897.345645989553, 11924.284542927453, 11586.71033224176, 11598.478068487108, 11619.883801161881, 11796.587119450778, 12228.266304021787, 12002.819957700467, 12093.516259349879, 12155.392230388623, 12205.20666156697, 12283.938580307042, 8392.87410688828, 8530.829383412422, 8547.27348175412, 8634.654613815628, 8691.608877600649, 10233.84649230277, 12054.698632534257, 12281.692957675772, 12476.313802740937, 12487.063470239587], "value": 8378.9474029636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.6890729531697, 1453.832809226939, 1541.2139808697568, 1646.2674110021046, 1693.4665580342191, 8058.758237252877, 8267.503949763019, 8742.868856967143, 9365.110314520118, 9366.0, 8504.787380315494, 8738.169873861989, 8752.343574231927, 8975.910240897589, 8992.595333210005, 2373.6202207646825, 2396.95206095878, 2397.1490121007055, 2397.8441401308946, 2398.3764221302413, 2106.3575609439113, 2148.355493351996, 2370.2533701883935, 2401.8678972656585, 2451.0563433078305, 2316.2356422380576, 2372.039324073753, 2388.8088952883813, 2400.2679182849224, 2416.613341865302, 2312.5952958232324, 2354.411397150712, 2366.7396586375485, 2377.9286621401384, 2383.118246248899, 2353.082297903819, 2356.8585884846966, 2357.446000189954, 2367.7987371073477, 2388.725296590897, 8969.147930946614, 9005.0, 9037.231835294007, 9039.096090390974, 9045.547722613843, 5284.471552844723, 5339.466053394668, 5418.133098704227, 5418.620696551243, 5428.4028756836715, 3342.4317865962844, 3511.157322242643, 3557.3596752584526, 3571.14292569784, 3573.5175751273505, 1102.3606308341143, 1159.8086315757973, 1165.7668466306773, 1189.6668932698858, 1203.1157099531838, 11329.263597866195, 11330.943345283304, 11339.206255562114, 11409.714757131054, 11433.428328583537, 4418.447694038246, 4586.197415452282, 4694.671373003857, 4783.689060211075, 4810.95189048112, 10213.438260895722, 10222.386656800616, 10233.43716095607, 10256.282060255711, 10262.230332724926, 5386.165144402624, 5389.568834493231, 5395.3525576931015, 5396.325459317585, 5397.10947693634, 4918.2376731606655, 4974.32846565709, 4977.328060711758, 4982.402111746614, 4995.425526064477, 3846.6345697158727, 3873.903152421212, 3916.9020774480864, 3940.2513522430645, 3976.642102210757, 1117.8379135025539, 1138.4478527913955, 1178.9941050294694, 1179.7758425899224, 1197.820326950947, 959.6305422412421, 962.3456049886145, 976.9364991275686, 983.3313346924017, 998.3211416237028, 6183.021433141352, 6233.781817636361, 6262.624242545462, 6310.368963103745, 6379.872402551923, 964.3439988131123, 976.9071938166005, 992.8758905136858, 1014.6245889020962, 1019.8062368150028, 4035.3745169498775, 4240.109576988867, 4242.936355954663, 4273.807678654468, 4294.441722576107, 11179.720506987227, 11374.090072794157, 11531.827022594667, 11543.538258469735, 11553.537858485735, 11394.202405831513, 11403.486843091914, 11405.543778248777, 11407.885921140849, 11412.486438110305, 8259.463134896332, 8288.58557072144, 8360.58197090143, 8360.958195209107, 8374.539400332918, 6034.456898879122, 6040.969795150996, 6070.210872586712, 6164.969175154096, 6185.6907154641185, 10144.644937427154, 10195.847062293924, 10216.642417515352, 10364.119049880845, 10550.419726915094, 10527.684169474927, 10628.84056739165, 10678.359298442118, 10723.89276107229, 10742.462876855969, 7579.2420757925975, 7632.1986191451315, 7672.271134242238, 7687.5387476751575, 7691.346235570039, 8557.743267701979, 8661.437006594551, 8735.956320218613, 8755.60599772999, 8760.12398760119, 7732.304092631465, 7762.262585054411, 7790.571518566533, 7807.609619519115, 8090.0696419912465, 7615.581143037186, 7744.883826742491, 7759.456838021284, 7820.452568320163, 7824.334931530883, 6476.319986401549, 6736.461083113241, 7243.130824301117, 7297.489175757646, 7317.341439270278, 5274.180407759317, 5324.653897496651, 5385.0037743017665, 5438.347398312228, 5635.577331700057, 5429.185622156708, 5494.642848214853, 5534.1975413565615, 5596.272484576979, 5616.1856530803625], "value": 4718.704948097466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.24610197220744, 321.30597908517603, 327.85410492330925, 328.0977312390924, 332.187800826978, 5055.84832455026, 5185.381382401886, 5223.6343455958095, 5252.921206181905, 5271.868203294915, 5143.742812859361, 5148.2020286855595, 5174.146265866128, 5190.351206099238, 5211.218317252414, 4077.8980525486804, 4087.386891966214, 4093.7543747375103, 4118.196951594433, 4129.587041295877, 3943.0, 4116.650084742801, 4141.585841415849, 4142.8135733891895, 4165.291900376943, 4047.433359329696, 4053.655439287664, 4067.8169482373214, 4084.0810817566107, 4085.7957102144774, 4047.797610119512, 4060.3909413587903, 4077.694172937027, 4077.7553346799286, 4093.7339072960162, 3588.8743893963588, 3595.227026189356, 3598.514200582914, 3601.9099522511883, 3605.1708107135505, 4969.310434452267, 5089.643724939256, 5102.795888164469, 5137.766935935349, 5156.458571849977, 4635.165670179366, 4646.303054541812, 4660.16117098922, 4673.205555055649, 4680.531946805327, 5436.510714035716, 5456.8090116846115, 5469.781208751645, 5499.835004949858, 5509.421510741395, 3811.428285757131, 3911.198204368098, 3924.7448915820664, 3933.115049113955, 3965.3457179565626, 5339.41266460689, 5504.394516603171, 5638.154276858463, 5658.179563963244, 5668.518175955049, 3887.747296425723, 3960.5643379228263, 3974.4435778990965, 3977.5624681285035, 3977.661898738582, 3826.196498735241, 3919.549251836075, 3929.0728407336146, 4024.69814763888, 4025.6980726445636, 4552.226121559343, 4562.7262364257585, 4575.0, 4583.129205450954, 4609.700369476041, 5414.91877621836, 5416.539594134464, 5423.891522169534, 5424.728763561806, 5429.348478182644, 1348.6560926963757, 1352.95146261648, 1353.6818847570812, 1376.6764810269578, 1400.103933482572, 870.9608067636972, 881.1981097201516, 885.7785553611598, 890.1854802855444, 903.2954295649404, 4710.610369940876, 4711.646626502958, 4716.976415117902, 4719.693219940693, 4731.1720448921305, 4921.532454416824, 4927.77824997876, 4937.506249375106, 4948.901021979612, 4952.579030782352, 4688.765561721901, 4706.623470122382, 4722.6221902247735, 4728.858134255978, 4733.928991065068, 2754.807163498576, 2964.710350997323, 2979.554915865803, 2994.7422082725307, 2996.9700302997126, 5833.854153646108, 5846.883062338729, 5852.092925596539, 5863.824085277449, 5879.2950044486615, 5456.61803673739, 5656.604037717402, 5699.914501282484, 5791.623544469596, 5794.246747922743, 5782.392848750989, 5786.942130578725, 5792.9710351447975, 5804.970975145097, 5816.73824677882, 5595.216669666169, 5602.747876345493, 5604.85987850307, 5626.409227031103, 5657.773689052557, 5320.840374788762, 5478.698671573102, 5491.615586908878, 5501.807436739695, 5534.035417426917, 5750.396208398225, 5764.625299355528, 5772.134179873053, 5793.652380857162, 5844.883102337844, 3903.2583809076186, 3959.4852669152824, 3967.682585393219, 4001.8394665546666, 4014.9197016060098, 5490.752916118704, 5496.340439147328, 5507.5593952484505, 5528.668279903058, 5538.972305138448, 5342.732863356739, 5350.491703288181, 5358.678479291255, 5395.4604539545735, 5400.9459905400445, 5325.440828712929, 5335.146376579729, 5382.623216374973, 5404.432534583812, 5420.53925416344, 5339.813106541253, 5342.759575819176, 5368.664630885577, 5394.221975682605, 5409.268319498628, 5460.3993560707495, 5471.425500322409, 5481.972590137183, 5516.172574113754, 5517.172424136412, 5084.440711521655, 5306.177542480922, 5324.414314425488, 5330.493603107699, 5398.379186393615], "value": 4110.730104235448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.7843025522598, 750.7860259825951, 779.1585088104847, 782.4483738964024, 822.6873787960574, 14438.855611443896, 15150.54548363548, 15232.238388080594, 15308.0, 15325.770113448294, 13940.651483712913, 13950.581482555539, 13967.231802250897, 13968.580942571714, 13977.23125228112, 647.7376662451715, 662.0301258656068, 769.7459838253377, 787.5314188058096, 791.0902462168524, 765.7970637780993, 778.5912395992093, 790.0322105420871, 791.0428381658201, 792.1088775127981, 826.1820797410551, 830.4726498673356, 832.1553623072587, 832.5837081459271, 832.5837081459271, 678.5453745990199, 826.1036775099025, 827.0736774812189, 827.1191181391829, 828.2587084559316, 514.8275327765203, 580.2688612348429, 597.1490625858135, 598.9880202395927, 600.9188759517452, 14280.214588197645, 14314.284285785774, 14322.57032289033, 14694.779578306334, 14705.117692938351, 14055.648608784863, 14102.858971410256, 14606.926965365212, 14822.0, 14854.925725371411, 12900.677483062998, 12912.225266484042, 13452.461901523928, 13765.311734413239, 13805.654858628615, 4332.436783218193, 4481.0, 4493.146302202571, 4624.560666736655, 4640.67515273931, 78249.60875195645, 79184.60407697983, 79585.0, 79847.0, 79925.60037199836, 11259.831102533468, 11332.150088743212, 11478.426078696031, 11631.6510504685, 11964.0, 22152.446188845406, 22217.777822221895, 22356.0, 22381.44046398853, 22402.775972240393, 7810.804729881685, 7842.294193522496, 7976.162502937224, 7999.840003199904, 8289.461185022954, 4399.252127138394, 4438.289873620205, 4456.398386217819, 4471.888202794891, 4544.113897789899, 3324.069260607034, 3418.5214070030215, 3446.6897979181995, 3449.6205417404067, 3455.2225749206227, 559.0998492427188, 562.7073921560766, 579.3308728418683, 583.3990989281048, 591.382005803936, 576.9620917102542, 578.3724658745308, 616.4144063139945, 623.8596315828902, 685.2804555217002, 8952.731418057469, 9253.768655783659, 9360.90639093614, 9512.476813775309, 10061.39631622105, 633.4805459523238, 634.4044727510316, 670.778643047793, 681.5637991685326, 704.4681265644406, 4320.546342633978, 4521.773911304422, 4603.631709463235, 4649.5350464953235, 4691.554302341272, 115236.0, 119455.0, 119935.81027035632, 125736.0, 125949.0, 105344.47327763465, 107699.0, 108382.45808770906, 110443.0, 112199.0, 93234.53382733042, 94829.5258523703, 95365.52317238369, 96229.5188524053, 98609.50695246478, 8627.16091339348, 8735.301175905784, 8817.823643527221, 8984.640614375352, 9018.954905225432, 51959.0, 52463.47536524586, 53221.46778532165, 53486.465135348146, 55134.172987406026, 71353.0, 73097.26902730904, 78621.0, 79570.0, 81111.56665300051, 12074.39628018613, 12088.335141566946, 12274.631761047183, 12301.138920275494, 12405.62783116508, 12665.430055647334, 12943.158694684815, 13027.413766380725, 13074.150180238254, 13592.796108058585, 12602.180858244184, 12768.170068945488, 12860.935695321463, 13118.699414317165, 13259.138156019828, 12169.634910952685, 13135.540256091374, 13276.137051091648, 13282.136661116996, 13284.26936518462, 11822.704432389259, 12072.3360215189, 12322.075844311534, 12437.253764774143, 12802.67993300175, 9767.267454940766, 10427.113695335982, 10516.57933682644, 10693.09108725767, 10843.620473283398, 8706.347023973354, 9075.183233509017, 9198.540072996457, 9273.30450216223, 9696.466694331879], "value": 7367.267979525116, "unit": "score"}], "name": "dromaeo_css", "value": 7075.379161631623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 112.0, 110.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 121.0, 155.0, 122.0, 123.0, 118.0, 120.0, 162.0, 118.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 117.0, 76.0, 76.0, 77.0, 76.0, 105.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 82.0, 82.0, 82.0, 102.0, 82.0, 82.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 49.0, 51.0, 50.0, 53.0, 50.0, 51.0, 51.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 77.0, 78.0, 81.0, 79.0, 78.0, 78.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 138.0, 123.0, 123.0, 125.0, 130.0, 129.0, 163.0, 125.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 165.0, 174.0, 164.0, 163.0, 166.0, 166.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 67.0, 70.0, 66.0, 63.0, 65.0, 63.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1482.8, "alertThreshold": 2.0}]} 12:32:42 INFO - Return code: 0 12:32:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:32:42 INFO - # TBPL SUCCESS # 12:32:42 INFO - Running post-action listener: _resource_record_post_action 12:32:42 INFO - [mozharness: 2016-09-28 19:32:42.887093Z] Finished run-tests step (success) 12:32:42 INFO - Running post-run listener: _resource_record_post_run 12:32:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404344832; Read time: 8; Write time: 317236 12:32:42 INFO - TinderboxPrint: CPU usage
13.1% 12:32:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:32:42 INFO - TinderboxPrint: I/O write bytes / time
404,344,832 / 317,236 12:32:42 INFO - TinderboxPrint: CPU idle
8,295.2 (86.9%) 12:32:42 INFO - TinderboxPrint: CPU user
1,196.6 (12.5%) 12:32:42 INFO - TinderboxPrint: Swap in / out
0 / 0 12:32:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 114470912; Read time: 0; Write time: 99832 12:32:42 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288976896; Read time: 8; Write time: 217384 12:32:43 INFO - Running post-run listener: _upload_blobber_files 12:32:43 INFO - Blob upload gear active. 12:32:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:32:43 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 12:32:43 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'] 12:32:43 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 12:32:43 INFO - (blobuploader) - INFO - Open directory for files ... 12:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:32:51 INFO - (blobuploader) - INFO - Done attempting. 12:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:32:52 INFO - (blobuploader) - INFO - Done attempting. 12:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:32:52 INFO - (blobuploader) - INFO - Done attempting. 12:32:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:32:53 INFO - Return code: 0 12:32:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:32:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:32:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb1f1054776d4aefef5b2acd7c00aef94af961ed0a680bb02b3677922076574c737a840b7f4d0d6e54ecd36538b6e1b98c0ffa27862563587c7b3d5276e9f320", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31d3b353c8f15070ae1da0ad1bd30ca7bbc226f3123948100b0cf13d52313c5e385990b94107b12b09ddc29f246648cae2f6cd088c999e6e8423375b227a0cb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960c1e5f311fb0f8e0b63df639117f2e7a14ec5b2cf99361af1a823f0badb07c4054fac956a3938262517b29313f660675b7e62b60222a2248d190fe54e52839"} 12:32:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:32:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:32:53 INFO - Contents: 12:32:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb1f1054776d4aefef5b2acd7c00aef94af961ed0a680bb02b3677922076574c737a840b7f4d0d6e54ecd36538b6e1b98c0ffa27862563587c7b3d5276e9f320", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31d3b353c8f15070ae1da0ad1bd30ca7bbc226f3123948100b0cf13d52313c5e385990b94107b12b09ddc29f246648cae2f6cd088c999e6e8423375b227a0cb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960c1e5f311fb0f8e0b63df639117f2e7a14ec5b2cf99361af1a823f0badb07c4054fac956a3938262517b29313f660675b7e62b60222a2248d190fe54e52839"} 12:32:53 INFO - Running post-run listener: copy_logs_to_upload_dir 12:32:53 INFO - Copying logs to upload dir... 12:32:53 INFO - mkdir: /builds/slave/test/build/upload/logs 12:32:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.490497 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 12:32:52.594954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 12:32:52.598151) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 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/eb1f1054776d4aefef5b2acd7c00aef94af961ed0a680bb02b3677922076574c737a840b7f4d0d6e54ecd36538b6e1b98c0ffa27862563587c7b3d5276e9f320", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31d3b353c8f15070ae1da0ad1bd30ca7bbc226f3123948100b0cf13d52313c5e385990b94107b12b09ddc29f246648cae2f6cd088c999e6e8423375b227a0cb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960c1e5f311fb0f8e0b63df639117f2e7a14ec5b2cf99361af1a823f0badb07c4054fac956a3938262517b29313f660675b7e62b60222a2248d190fe54e52839"} build_url:https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/Ru66j4-KQYSItkK0_ZcNxQ/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/eb1f1054776d4aefef5b2acd7c00aef94af961ed0a680bb02b3677922076574c737a840b7f4d0d6e54ecd36538b6e1b98c0ffa27862563587c7b3d5276e9f320", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31d3b353c8f15070ae1da0ad1bd30ca7bbc226f3123948100b0cf13d52313c5e385990b94107b12b09ddc29f246648cae2f6cd088c999e6e8423375b227a0cb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960c1e5f311fb0f8e0b63df639117f2e7a14ec5b2cf99361af1a823f0badb07c4054fac956a3938262517b29313f660675b7e62b60222a2248d190fe54e52839"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 12:32:52.628058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:32:52.628733) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475084449.967830-452738068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:32:52.711746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 12:32:52.712084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 12:32:52.712417) ========= ========= Total master_lag: 0.18 =========