builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1475090461.59 results: success (0) buildid: 20160928093037 builduid: d9ce418ed74942e8ac83eab6bd20319d revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.588675) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.589522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.590059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.633618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.633988) ========= 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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 12:21:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.7M=0s 2016-09-28 12:21:03 (77.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.734880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.735191) ========= 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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:01.787060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 12:21:01.787874) ========= 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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 12:21:03,132 truncating revision to first 12 chars 2016-09-28 12:21:03,132 Setting DEBUG logging. 2016-09-28 12:21:03,132 attempt 1/10 2016-09-28 12:21:03,132 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:21:04,306 unpacking tar archive at: fx-team-eda310265741/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 12:21:03.407980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:03.408742) ========= script_repo_revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:03.409929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:03.410715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 12:21:03.423848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 12:21:03.424467) ========= /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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:21:04 INFO - MultiFileLogger online at 20160928 12:21:04 in /builds/slave/test 12:21:04 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:21:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:21:04 INFO - {'append_to_log': False, 12:21:04 INFO - 'base_work_dir': '/builds/slave/test', 12:21:04 INFO - 'blob_upload_branch': 'Fx-Team', 12:21:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:21:04 INFO - 'branch': 'Fx-Team', 12:21:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:21:04 INFO - 'config_files': ('talos/linux_config.py',), 12:21:04 INFO - 'default_actions': ('clobber', 12:21:04 INFO - 'read-buildbot-config', 12:21:04 INFO - 'download-and-extract', 12:21:04 INFO - 'populate-webroot', 12:21:04 INFO - 'create-virtualenv', 12:21:04 INFO - 'install', 12:21:04 INFO - 'run-tests'), 12:21:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:21:04 INFO - 'download_minidump_stackwalk': True, 12:21:04 INFO - 'download_symbols': 'ondemand', 12:21:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:21:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:21:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:21:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:21:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:21:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:21:04 INFO - 'installer_path': 'installer.exe', 12:21:04 INFO - 'log_level': 'info', 12:21:04 INFO - 'log_name': 'talos', 12:21:04 INFO - 'log_to_console': True, 12:21:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:21:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:21:04 INFO - 'opt_config_files': (), 12:21:04 INFO - 'pip_index': False, 12:21:04 INFO - 'sps_profile': False, 12:21:04 INFO - 'sps_profile_interval': 0, 12:21:04 INFO - 'suite': 'dromaeojs', 12:21:04 INFO - 'system_bits': '32', 12:21:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:21:04 INFO - 'title': 'talos-linux64-ix-048', 12:21:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:21:04 INFO - 'use_talos_json': True, 12:21:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:21:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:21:04 INFO - 'work_dir': 'build'} 12:21:04 INFO - [mozharness: 2016-09-28 19:21:04.867949Z] Running clobber step. 12:21:04 INFO - Running pre-action listener: _resource_record_pre_action 12:21:04 INFO - Running main action method: clobber 12:21:04 INFO - rmtree: /builds/slave/test/build 12:21:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:05 INFO - Running post-action listener: _resource_record_post_action 12:21:05 INFO - [mozharness: 2016-09-28 19:21:05.842056Z] Finished clobber step (success) 12:21:05 INFO - [mozharness: 2016-09-28 19:21:05.842213Z] Running read-buildbot-config step. 12:21:05 INFO - Running pre-action listener: _resource_record_pre_action 12:21:05 INFO - Running main action method: read_buildbot_config 12:21:05 INFO - Using buildbot properties: 12:21:05 INFO - { 12:21:05 INFO - "project": "", 12:21:05 INFO - "product": "firefox", 12:21:05 INFO - "script_repo_revision": "production", 12:21:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:21:05 INFO - "repository": "", 12:21:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:21:05 INFO - "buildid": "20160928093037", 12:21:05 INFO - "pgo_build": "True", 12:21:05 INFO - "basedir": "/builds/slave/test", 12:21:05 INFO - "buildnumber": 1603, 12:21:05 INFO - "slavename": "talos-linux64-ix-048", 12:21:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:21:05 INFO - "platform": "ubuntu64_hw", 12:21:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:21:05 INFO - "branch": "fx-team", 12:21:05 INFO - "repo_path": "integration/fx-team", 12:21:05 INFO - "revision": "eda310265741fb26bbd91a92017bc6337fcc8de6", 12:21:05 INFO - "stage_platform": "linux64-pgo", 12:21:05 INFO - "builduid": "d9ce418ed74942e8ac83eab6bd20319d", 12:21:05 INFO - "slavebuilddir": "test" 12:21:05 INFO - } 12:21:05 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:21:05 INFO - Running post-action listener: _resource_record_post_action 12:21:05 INFO - [mozharness: 2016-09-28 19:21:05.844650Z] Finished read-buildbot-config step (success) 12:21:05 INFO - [mozharness: 2016-09-28 19:21:05.844739Z] Running download-and-extract step. 12:21:05 INFO - Running pre-action listener: _resource_record_pre_action 12:21:05 INFO - Running main action method: download_and_extract 12:21:05 INFO - mkdir: /builds/slave/test/build/tests 12:21:05 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:21:05 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:21:05 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:21:05 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:21:06 INFO - Downloaded 1361 bytes. 12:21:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:21:06 INFO - Using the following test package requirements: 12:21:06 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:21:06 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:21:06 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:21:06 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'jsshell-linux-x86_64.zip'], 12:21:06 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:21:06 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:21:06 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:21:06 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:21:06 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:21:06 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:21:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:21:06 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:21:06 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:21:06 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:21:07 INFO - Expected file size: 21987205 12:21:07 INFO - Content-Encoding None 12:21:07 INFO - Content-Type application/zip 12:21:07 INFO - Http code 200 12:21:11 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:21: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:21: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:21: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:21:12 INFO - Expected file size: 21987205 12:21:12 INFO - Content-Encoding None 12:21:12 INFO - Content-Type application/zip 12:21:12 INFO - Http code 200 12:21: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.talos.tests.zip 12:21: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.talos.tests.zip'}, attempt #1 12:21:16 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:21:17 INFO - Expected file size: 14414067 12:21:17 INFO - Content-Encoding None 12:21:17 INFO - Content-Type application/zip 12:21:17 INFO - Http code 200 12:21:17 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:21:17 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:21:17 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:21:17 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:21:18 INFO - Downloaded 59739016 bytes. 12:21:18 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:21:18 INFO - mkdir: /builds/slave/test/properties 12:21:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:21:18 INFO - Writing to file /builds/slave/test/properties/build_url 12:21:18 INFO - Contents: 12:21:18 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:21:19 INFO - Running post-action listener: _resource_record_post_action 12:21:19 INFO - Running post-action listener: set_extra_try_arguments 12:21:19 INFO - [mozharness: 2016-09-28 19:21:19.647277Z] Finished download-and-extract step (success) 12:21:19 INFO - [mozharness: 2016-09-28 19:21:19.647505Z] Running populate-webroot step. 12:21:19 INFO - Running pre-action listener: _resource_record_pre_action 12:21:19 INFO - Running main action method: populate_webroot 12:21:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:21:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:21:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:21:19 INFO - '--tppagecycles', 12:21:19 INFO - '7'], 12:21:19 INFO - 'tests': ['tsvgm']}}, 12:21:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:21:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:21:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:21:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:21:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['damp', 'tps']}, 12:21:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'tests': ['damp', 'tps']}, 12:21:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['dromaeo_dom']}, 12:21:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:21:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['basic_compositor_video']}, 12:21:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:21:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'other-e10s': {'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['a11yr', 12:21:19 INFO - 'ts_paint', 12:21:19 INFO - 'tpaint', 12:21:19 INFO - 'sessionrestore', 12:21:19 INFO - 'sessionrestore_no_auto_restore', 12:21:19 INFO - 'tabpaint']}, 12:21:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['tsvgx', 12:21:19 INFO - 'tsvgr_opacity', 12:21:19 INFO - 'tart', 12:21:19 INFO - 'tscrollx', 12:21:19 INFO - 'cart']}, 12:21:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:21:19 INFO - 'tsvgr_opacity', 12:21:19 INFO - 'tart', 12:21:19 INFO - 'tscrollx', 12:21:19 INFO - 'cart']}, 12:21:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'talos_options': ['--disable-e10s'], 12:21:19 INFO - 'tests': ['tp5o']}, 12:21:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'tests': ['tp5o']}, 12:21:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'talos_options': ['--disable-e10s', 12:21:19 INFO - '--xperf_path', 12:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:19 INFO - 'tests': ['tp5n']}, 12:21:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:19 INFO - 'talos_options': ['--xperf_path', 12:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:19 INFO - 'tests': ['tp5n']}}, 12:21:19 INFO - 'talos.zip': {'path': '', 12:21:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:21:19 INFO - Running post-action listener: _resource_record_post_action 12:21:19 INFO - [mozharness: 2016-09-28 19:21:19.667565Z] Finished populate-webroot step (success) 12:21:19 INFO - [mozharness: 2016-09-28 19:21:19.667654Z] Running create-virtualenv step. 12:21:19 INFO - Running pre-action listener: _resource_record_pre_action 12:21:19 INFO - Running main action method: create_virtualenv 12:21:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:21:19 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:21:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:21:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:21:19 INFO - Using real prefix '/usr' 12:21:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:21:20 INFO - Installing distribute.............................................................................................................................................................................................done. 12:21:22 INFO - Installing pip.................done. 12:21:22 INFO - Return code: 0 12:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:21:22 INFO - Reading from file tmpfile_stdout 12:21:22 INFO - Output received: 12:21:22 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:21:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:21: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:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:22 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:22 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:21:22 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:21:22 INFO - Using env: {'DISPLAY': ':0', 12:21:22 INFO - 'HOME': '/home/cltbld', 12:21:22 INFO - 'LANG': 'en_US.UTF-8', 12:21:22 INFO - 'LANGUAGE': 'en_US:en', 12:21:22 INFO - 'LOGNAME': 'cltbld', 12:21:22 INFO - 'MAIL': '/var/mail/cltbld', 12:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:22 INFO - 'MOZ_NO_REMOTE': '1', 12:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:22 INFO - 'NO_EM_RESTART': '1', 12:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:22 INFO - 'PWD': '/builds/slave/test', 12:21:22 INFO - 'SHELL': '/bin/bash', 12:21:22 INFO - 'SHLVL': '1', 12:21:22 INFO - 'TERM': 'linux', 12:21:22 INFO - 'TMOUT': '86400', 12:21:22 INFO - 'USER': 'cltbld', 12:21:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:22 INFO - '_': '/tools/buildbot/bin/python'} 12:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:22 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:21:22 INFO - Cleaning up... 12:21:22 INFO - Return code: 0 12:21:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:21: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:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:22 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:22 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:21:22 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:21:22 INFO - Using env: {'DISPLAY': ':0', 12:21:22 INFO - 'HOME': '/home/cltbld', 12:21:22 INFO - 'LANG': 'en_US.UTF-8', 12:21:22 INFO - 'LANGUAGE': 'en_US:en', 12:21:22 INFO - 'LOGNAME': 'cltbld', 12:21:22 INFO - 'MAIL': '/var/mail/cltbld', 12:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:22 INFO - 'MOZ_NO_REMOTE': '1', 12:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:22 INFO - 'NO_EM_RESTART': '1', 12:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:22 INFO - 'PWD': '/builds/slave/test', 12:21:22 INFO - 'SHELL': '/bin/bash', 12:21:22 INFO - 'SHLVL': '1', 12:21:22 INFO - 'TERM': 'linux', 12:21:22 INFO - 'TMOUT': '86400', 12:21:22 INFO - 'USER': 'cltbld', 12:21:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:22 INFO - '_': '/tools/buildbot/bin/python'} 12:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:22 INFO - Downloading/unpacking psutil>=3.1.1 12:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:21:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:24 INFO - Installing collected packages: psutil 12:21:24 INFO - Running setup.py install for psutil 12:21:24 INFO - building 'psutil._psutil_linux' extension 12:21:24 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:21:25 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:21:25 INFO - building 'psutil._psutil_posix' extension 12:21:25 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:21:25 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:21:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:25 INFO - Successfully installed psutil 12:21:25 INFO - Cleaning up... 12:21:25 INFO - Return code: 0 12:21:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:21:25 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:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:25 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:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:25 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:25 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:21:25 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:21:25 INFO - Using env: {'DISPLAY': ':0', 12:21:25 INFO - 'HOME': '/home/cltbld', 12:21:25 INFO - 'LANG': 'en_US.UTF-8', 12:21:25 INFO - 'LANGUAGE': 'en_US:en', 12:21:25 INFO - 'LOGNAME': 'cltbld', 12:21:25 INFO - 'MAIL': '/var/mail/cltbld', 12:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:25 INFO - 'MOZ_NO_REMOTE': '1', 12:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:25 INFO - 'NO_EM_RESTART': '1', 12:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:25 INFO - 'PWD': '/builds/slave/test', 12:21:25 INFO - 'SHELL': '/bin/bash', 12:21:25 INFO - 'SHLVL': '1', 12:21:25 INFO - 'TERM': 'linux', 12:21:25 INFO - 'TMOUT': '86400', 12:21:25 INFO - 'USER': 'cltbld', 12:21:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:25 INFO - '_': '/tools/buildbot/bin/python'} 12:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:21:27 INFO - Installing collected packages: mozsystemmonitor 12:21:27 INFO - Running setup.py install for mozsystemmonitor 12:21:27 INFO - Successfully installed mozsystemmonitor 12:21:27 INFO - Cleaning up... 12:21:27 INFO - Return code: 0 12:21:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:21: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:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:21: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 jsonschema==2.5.1 12:21:27 INFO - Using env: {'DISPLAY': ':0', 12:21:27 INFO - 'HOME': '/home/cltbld', 12:21:27 INFO - 'LANG': 'en_US.UTF-8', 12:21:27 INFO - 'LANGUAGE': 'en_US:en', 12:21:27 INFO - 'LOGNAME': 'cltbld', 12:21:27 INFO - 'MAIL': '/var/mail/cltbld', 12:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:27 INFO - 'MOZ_NO_REMOTE': '1', 12:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:27 INFO - 'NO_EM_RESTART': '1', 12:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:27 INFO - 'PWD': '/builds/slave/test', 12:21:27 INFO - 'SHELL': '/bin/bash', 12:21:27 INFO - 'SHLVL': '1', 12:21:27 INFO - 'TERM': 'linux', 12:21:27 INFO - 'TMOUT': '86400', 12:21:27 INFO - 'USER': 'cltbld', 12:21:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:27 INFO - '_': '/tools/buildbot/bin/python'} 12:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:27 INFO - Downloading/unpacking jsonschema==2.5.1 12:21: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:21: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:21: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:21: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:21: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:21: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:21:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:30 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:30 INFO - warning: no files found matching '*.txt' 12:21:30 INFO - no previously-included directories found matching 'build' 12:21:30 INFO - no previously-included directories found matching 'dist' 12:21:30 INFO - no previously-included directories found matching '.git*' 12:21:30 INFO - Installing collected packages: jsonschema, functools32 12:21:30 INFO - Running setup.py install for functools32 12:21:30 INFO - warning: no files found matching '*.txt' 12:21:30 INFO - no previously-included directories found matching 'build' 12:21:30 INFO - no previously-included directories found matching 'dist' 12:21:30 INFO - no previously-included directories found matching '.git*' 12:21:30 INFO - Successfully installed jsonschema functools32 12:21:30 INFO - Cleaning up... 12:21:30 INFO - Return code: 0 12:21:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:21: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:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:21: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 functools32==3.2.3-2 12:21:30 INFO - Using env: {'DISPLAY': ':0', 12:21:30 INFO - 'HOME': '/home/cltbld', 12:21:30 INFO - 'LANG': 'en_US.UTF-8', 12:21:30 INFO - 'LANGUAGE': 'en_US:en', 12:21:30 INFO - 'LOGNAME': 'cltbld', 12:21:30 INFO - 'MAIL': '/var/mail/cltbld', 12:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:30 INFO - 'MOZ_NO_REMOTE': '1', 12:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:30 INFO - 'NO_EM_RESTART': '1', 12:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:30 INFO - 'PWD': '/builds/slave/test', 12:21:30 INFO - 'SHELL': '/bin/bash', 12:21:30 INFO - 'SHLVL': '1', 12:21:30 INFO - 'TERM': 'linux', 12:21:30 INFO - 'TMOUT': '86400', 12:21:30 INFO - 'USER': 'cltbld', 12:21:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:30 INFO - '_': '/tools/buildbot/bin/python'} 12:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:21:30 INFO - Cleaning up... 12:21:30 INFO - Return code: 0 12:21:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21: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:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:21: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 blobuploader==1.2.4 12:21:30 INFO - Using env: {'DISPLAY': ':0', 12:21:30 INFO - 'HOME': '/home/cltbld', 12:21:30 INFO - 'LANG': 'en_US.UTF-8', 12:21:30 INFO - 'LANGUAGE': 'en_US:en', 12:21:30 INFO - 'LOGNAME': 'cltbld', 12:21:30 INFO - 'MAIL': '/var/mail/cltbld', 12:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:30 INFO - 'MOZ_NO_REMOTE': '1', 12:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:30 INFO - 'NO_EM_RESTART': '1', 12:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:30 INFO - 'PWD': '/builds/slave/test', 12:21:30 INFO - 'SHELL': '/bin/bash', 12:21:30 INFO - 'SHLVL': '1', 12:21:30 INFO - 'TERM': 'linux', 12:21:30 INFO - 'TMOUT': '86400', 12:21:30 INFO - 'USER': 'cltbld', 12:21:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:30 INFO - '_': '/tools/buildbot/bin/python'} 12:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:21: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:21: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:21: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:21: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:21: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:21: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:21:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21: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:21: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:21: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:21: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:21: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:21: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:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:33 INFO - Downloading docopt-0.6.1.tar.gz 12:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:33 INFO - Running setup.py install for blobuploader 12:21:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:33 INFO - Running setup.py install for requests 12:21:33 INFO - Running setup.py install for docopt 12:21:33 INFO - Successfully installed blobuploader requests docopt 12:21:33 INFO - Cleaning up... 12:21:34 INFO - Return code: 0 12:21:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:34 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:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:34 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:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:34 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:34 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:21:34 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:21:34 INFO - Using env: {'DISPLAY': ':0', 12:21:34 INFO - 'HOME': '/home/cltbld', 12:21:34 INFO - 'LANG': 'en_US.UTF-8', 12:21:34 INFO - 'LANGUAGE': 'en_US:en', 12:21:34 INFO - 'LOGNAME': 'cltbld', 12:21:34 INFO - 'MAIL': '/var/mail/cltbld', 12:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:34 INFO - 'MOZ_NO_REMOTE': '1', 12:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:34 INFO - 'NO_EM_RESTART': '1', 12:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:34 INFO - 'PWD': '/builds/slave/test', 12:21:34 INFO - 'SHELL': '/bin/bash', 12:21:34 INFO - 'SHLVL': '1', 12:21:34 INFO - 'TERM': 'linux', 12:21:34 INFO - 'TMOUT': '86400', 12:21:34 INFO - 'USER': 'cltbld', 12:21:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:34 INFO - '_': '/tools/buildbot/bin/python'} 12:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:34 INFO - Running setup.py (path:/tmp/pip-hXahM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:34 INFO - Running setup.py (path:/tmp/pip-S97SVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:34 INFO - Running setup.py (path:/tmp/pip-NewUeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:34 INFO - Running setup.py (path:/tmp/pip-PJIQNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:34 INFO - Running setup.py (path:/tmp/pip-CvfNEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:34 INFO - Running setup.py (path:/tmp/pip-SRte5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:34 INFO - Running setup.py (path:/tmp/pip-2Y8Fca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:34 INFO - Running setup.py (path:/tmp/pip-DJUfNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:34 INFO - Running setup.py (path:/tmp/pip-tLxJX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:34 INFO - Running setup.py (path:/tmp/pip-e38Tbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:34 INFO - Running setup.py (path:/tmp/pip-VCWJ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:35 INFO - Running setup.py (path:/tmp/pip-qQ0ZPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:35 INFO - Running setup.py (path:/tmp/pip-8hm2UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:35 INFO - Running setup.py (path:/tmp/pip-tTq98c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:35 INFO - Running setup.py (path:/tmp/pip-sTJhnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:35 INFO - Running setup.py (path:/tmp/pip-hp4ijU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:35 INFO - Running setup.py (path:/tmp/pip-3oGNl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:35 INFO - Running setup.py install for manifestparser 12:21:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:35 INFO - Running setup.py install for mozcrash 12:21:35 INFO - Running setup.py install for mozdebug 12:21:35 INFO - Running setup.py install for mozdevice 12:21:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:21:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:35 INFO - Running setup.py install for mozfile 12:21:36 INFO - Running setup.py install for mozhttpd 12:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozinfo 12:21:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozInstall 12:21:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozleak 12:21:36 INFO - Running setup.py install for mozlog 12:21:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for moznetwork 12:21:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozprocess 12:21:36 INFO - Running setup.py install for mozprofile 12:21:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozrunner 12:21:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:36 INFO - Running setup.py install for mozscreenshot 12:21:37 INFO - Running setup.py install for moztest 12:21:37 INFO - Running setup.py install for mozversion 12:21:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:37 INFO - Cleaning up... 12:21:37 INFO - Return code: 0 12:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:37 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:37 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:21:37 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:21:37 INFO - Using env: {'DISPLAY': ':0', 12:21:37 INFO - 'HOME': '/home/cltbld', 12:21:37 INFO - 'LANG': 'en_US.UTF-8', 12:21:37 INFO - 'LANGUAGE': 'en_US:en', 12:21:37 INFO - 'LOGNAME': 'cltbld', 12:21:37 INFO - 'MAIL': '/var/mail/cltbld', 12:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:37 INFO - 'MOZ_NO_REMOTE': '1', 12:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:37 INFO - 'NO_EM_RESTART': '1', 12:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:37 INFO - 'PWD': '/builds/slave/test', 12:21:37 INFO - 'SHELL': '/bin/bash', 12:21:37 INFO - 'SHLVL': '1', 12:21:37 INFO - 'TERM': 'linux', 12:21:37 INFO - 'TMOUT': '86400', 12:21:37 INFO - 'USER': 'cltbld', 12:21:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:37 INFO - '_': '/tools/buildbot/bin/python'} 12:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:37 INFO - Running setup.py (path:/tmp/pip-sB3QZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:37 INFO - Running setup.py (path:/tmp/pip-40X2gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:37 INFO - Running setup.py (path:/tmp/pip-iahUFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:37 INFO - Running setup.py (path:/tmp/pip-aHMdVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:37 INFO - Running setup.py (path:/tmp/pip-A39tzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:37 INFO - Running setup.py (path:/tmp/pip-dpoN0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:37 INFO - Running setup.py (path:/tmp/pip-5yFkHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:38 INFO - Running setup.py (path:/tmp/pip-_1y17x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:38 INFO - Running setup.py (path:/tmp/pip-PEQ1e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:38 INFO - Running setup.py (path:/tmp/pip-uLsYIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:38 INFO - Running setup.py (path:/tmp/pip-zmI63z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:38 INFO - Running setup.py (path:/tmp/pip-uuc8Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:38 INFO - Running setup.py (path:/tmp/pip-rPm4sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:38 INFO - Running setup.py (path:/tmp/pip-yKIMpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:38 INFO - Running setup.py (path:/tmp/pip-fEPnO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:38 INFO - Running setup.py (path:/tmp/pip-9bx6H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:38 INFO - Running setup.py (path:/tmp/pip-kEM4wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:40 INFO - Downloading blessings-1.6.tar.gz 12:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:40 INFO - Installing collected packages: blessings 12:21:40 INFO - Running setup.py install for blessings 12:21:40 INFO - Successfully installed blessings 12:21:40 INFO - Cleaning up... 12:21:40 INFO - Return code: 0 12:21:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:41 INFO - Reading from file tmpfile_stdout 12:21:41 INFO - Current package versions: 12:21:41 INFO - argparse == 1.2.1 12:21:41 INFO - blessings == 1.6 12:21:41 INFO - blobuploader == 1.2.4 12:21:41 INFO - docopt == 0.6.1 12:21:41 INFO - functools32 == 3.2.3-2 12:21:41 INFO - jsonschema == 2.5.1 12:21:41 INFO - manifestparser == 1.1 12:21:41 INFO - mozInstall == 1.12 12:21:41 INFO - mozcrash == 0.17 12:21:41 INFO - mozdebug == 0.1 12:21:41 INFO - mozdevice == 0.48 12:21:41 INFO - mozfile == 1.2 12:21:41 INFO - mozhttpd == 0.7 12:21:41 INFO - mozinfo == 0.9 12:21:41 INFO - mozleak == 0.1 12:21:41 INFO - mozlog == 3.4 12:21:41 INFO - moznetwork == 0.27 12:21:41 INFO - mozprocess == 0.23 12:21:41 INFO - mozprofile == 0.28 12:21:41 INFO - mozrunner == 6.12 12:21:41 INFO - mozscreenshot == 0.1 12:21:41 INFO - mozsystemmonitor == 0.3 12:21:41 INFO - moztest == 0.7 12:21:41 INFO - mozversion == 1.4 12:21:41 INFO - psutil == 3.1.1 12:21:41 INFO - requests == 1.2.3 12:21:41 INFO - wsgiref == 0.1.2 12:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:41 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:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:41 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:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:41 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:41 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:21:41 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:21:41 INFO - Using env: {'DISPLAY': ':0', 12:21:41 INFO - 'HOME': '/home/cltbld', 12:21:41 INFO - 'LANG': 'en_US.UTF-8', 12:21:41 INFO - 'LANGUAGE': 'en_US:en', 12:21:41 INFO - 'LOGNAME': 'cltbld', 12:21:41 INFO - 'MAIL': '/var/mail/cltbld', 12:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:41 INFO - 'MOZ_NO_REMOTE': '1', 12:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:41 INFO - 'NO_EM_RESTART': '1', 12:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:41 INFO - 'PWD': '/builds/slave/test', 12:21:41 INFO - 'SHELL': '/bin/bash', 12:21:41 INFO - 'SHLVL': '1', 12:21:41 INFO - 'TERM': 'linux', 12:21:41 INFO - 'TMOUT': '86400', 12:21:41 INFO - 'USER': 'cltbld', 12:21:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:41 INFO - '_': '/tools/buildbot/bin/python'} 12:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 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:21:41 INFO - Cleaning up... 12:21:41 INFO - Return code: 0 12:21:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21:41 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:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:41 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:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:41 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 0x7f6e055f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', '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:21:41 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:21:41 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:21:41 INFO - Using env: {'DISPLAY': ':0', 12:21:41 INFO - 'HOME': '/home/cltbld', 12:21:41 INFO - 'LANG': 'en_US.UTF-8', 12:21:41 INFO - 'LANGUAGE': 'en_US:en', 12:21:41 INFO - 'LOGNAME': 'cltbld', 12:21:41 INFO - 'MAIL': '/var/mail/cltbld', 12:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:41 INFO - 'MOZ_NO_REMOTE': '1', 12:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:41 INFO - 'NO_EM_RESTART': '1', 12:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:41 INFO - 'PWD': '/builds/slave/test', 12:21:41 INFO - 'SHELL': '/bin/bash', 12:21:41 INFO - 'SHLVL': '1', 12:21:41 INFO - 'TERM': 'linux', 12:21:41 INFO - 'TMOUT': '86400', 12:21:41 INFO - 'USER': 'cltbld', 12:21:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:41 INFO - '_': '/tools/buildbot/bin/python'} 12:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:41 INFO - Cleaning up... 12:21:41 INFO - Return code: 0 12:21:41 INFO - Running post-action listener: _resource_record_post_action 12:21:41 INFO - Running post-action listener: _start_resource_monitoring 12:21:41 INFO - Starting resource monitoring. 12:21:41 INFO - [mozharness: 2016-09-28 19:21:41.597129Z] Finished create-virtualenv step (success) 12:21:41 INFO - [mozharness: 2016-09-28 19:21:41.597645Z] Running install step. 12:21:41 INFO - Running pre-action listener: _resource_record_pre_action 12:21:41 INFO - Running main action method: install 12:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:41 INFO - Reading from file tmpfile_stdout 12:21:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:41 INFO - Reading from file tmpfile_stdout 12:21:41 INFO - Output received: 12:21:41 INFO - Usage: mozinstall [options] installer 12:21:41 INFO - Options: 12:21:41 INFO - -h, --help show this help message and exit 12:21:41 INFO - -d DEST, --destination=DEST 12:21:41 INFO - Directory to install application into. [default: 12:21:41 INFO - "/builds/slave/test"] 12:21:41 INFO - --app=APP Application being installed. [default: firefox] 12:21:41 INFO - mkdir: /builds/slave/test/build/application 12:21:41 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:21:41 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:21:58 INFO - Reading from file tmpfile_stdout 12:21:58 INFO - Output received: 12:21:58 INFO - /builds/slave/test/build/application/firefox/firefox 12:21:58 INFO - Running post-action listener: _resource_record_post_action 12:21:58 INFO - [mozharness: 2016-09-28 19:21:58.884858Z] Finished install step (success) 12:21:58 INFO - [mozharness: 2016-09-28 19:21:58.885103Z] Running run-tests step. 12:21:58 INFO - Running pre-action listener: _resource_record_pre_action 12:21:58 INFO - Running main action method: run_tests 12:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:58 INFO - Python 2.7.3 12:21:58 INFO - Return code: 0 12:21:58 INFO - grabbing minidump binary from tooltool 12:21:58 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:21:58 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 0xefc930>, '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 0xefd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefdcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:58 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:21:58 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:21:58 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:21:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:58 INFO - Return code: 0 12:21:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:21:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:21:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:58 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-048', '--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:21:58 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-048 --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:21:58 INFO - Using env: {'DISPLAY': ':0', 12:21:58 INFO - 'HOME': '/home/cltbld', 12:21:58 INFO - 'LANG': 'en_US.UTF-8', 12:21:58 INFO - 'LANGUAGE': 'en_US:en', 12:21:58 INFO - 'LOGNAME': 'cltbld', 12:21:58 INFO - 'MAIL': '/var/mail/cltbld', 12:21:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:58 INFO - 'MOZ_NO_REMOTE': '1', 12:21:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:58 INFO - 'NO_EM_RESTART': '1', 12:21:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:58 INFO - 'PWD': '/builds/slave/test', 12:21:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:58 INFO - 'SHELL': '/bin/bash', 12:21:58 INFO - 'SHLVL': '1', 12:21:58 INFO - 'TERM': 'linux', 12:21:58 INFO - 'TMOUT': '86400', 12:21:58 INFO - 'USER': 'cltbld', 12:21:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695', 12:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:58 INFO - '_': '/tools/buildbot/bin/python'} 12:21:58 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-048', '--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:21:59 INFO - mozversion application_buildid: 20160928093037 12:21:59 INFO - mozversion application_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 12:21:59 INFO - mozversion application_display_name: Nightly 12:21:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:59 INFO - mozversion application_name: Firefox 12:21:59 INFO - mozversion application_remotingname: firefox 12:21:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:21:59 INFO - mozversion application_vendor: Mozilla 12:21:59 INFO - mozversion application_version: 52.0a1 12:21:59 INFO - mozversion platform_buildid: 20160928093037 12:21:59 INFO - mozversion platform_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 12:21:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:21:59 INFO - mozversion platform_version: 52.0a1 12:21:59 INFO - using testdate: 1475090519 12:21:59 INFO - actual date: 1475090519 12:21:59 INFO - starting webserver on 'localhost:52170' 12:21:59 INFO - SUITE-START | Running 2 tests 12:21:59 INFO - TEST-START | dromaeo_css 12:21:59 INFO - operating with platform_type : linux_ 12:21:59 INFO - Initialising browser for dromaeo_css test... 12:21:59 INFO - TEST-INFO | started process 27279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpat2wg_/profile http://localhost:52170/getInfo.html) 12:22:03 INFO - PROCESS | 27279 | __metrics Screen width/height:1600/1200 12:22:03 INFO - PROCESS | 27279 | colorDepth:24 12:22:03 INFO - PROCESS | 27279 | Browser inner width/height: 1024/697 12:22:03 INFO - PROCESS | 27279 | __metrics 12:22:04 INFO - PROCESS | 27279 | 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:22:04 INFO - PROCESS | 27279 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:04 INFO - PROCESS | 27279 | console.error: PushService: 12:22:04 INFO - PROCESS | 27279 | stateChangeProcessEnqueue: Error transitioning state 12:22:04 INFO - PROCESS | 27279 | UnknownError 12:22:05 INFO - TEST-INFO | 27279: exit 0 12:22:05 INFO - Browser initialized. 12:22:05 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:05 INFO - TEST-INFO | started process 27362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpat2wg_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:17 INFO - PROCESS | 27362 | RSS: Main: 173338624 12:22:17 INFO - PROCESS | 27362 | 12:23:08 INFO - PROCESS | 27362 | 1475090588861 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:25:19 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52170/tests/dromaeo/cssquery-ext.html) 12:25:20 INFO - PROCESS | 27362 | RSS: Main: 298598400 12:25:20 INFO - PROCESS | 27362 | 12:28:23 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-ext.html (next: http://localhost:52170/tests/dromaeo/cssquery-jquery.html) 12:28:23 INFO - PROCESS | 27362 | RSS: Main: 274833408 12:28:23 INFO - PROCESS | 27362 | 12:31:25 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52170/tests/dromaeo/cssquery-mootools.html) 12:31:26 INFO - PROCESS | 27362 | RSS: Main: 276443136 12:31:26 INFO - PROCESS | 27362 | 12:34:28 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52170/tests/dromaeo/cssquery-prototype.html) 12:34:28 INFO - PROCESS | 27362 | RSS: Main: 257720320 12:34:28 INFO - PROCESS | 27362 | 12:37:31 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52170/tests/dromaeo/cssquery-yui.html) 12:37:31 INFO - PROCESS | 27362 | RSS: Main: 217104384 12:37:31 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | Cycle 1(1): loaded http://localhost:52170/tests/dromaeo/cssquery-yui.html (next: http://localhost:52170/tests/dromaeo/cssquery-dojo.html) 12:40:35 INFO - PROCESS | 27362 | RSS: Main: 309661696 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | __start_tp_report 12:40:35 INFO - PROCESS | 27362 | _x_x_mozilla_page_load 12:40:35 INFO - PROCESS | 27362 | _x_x_mozilla_page_load_details 12:40:35 INFO - PROCESS | 27362 | |i|pagename|runs| 12:40:35 INFO - PROCESS | 27362 | |0;dojo.html;3061.51015837466;3106.2700265437634;3111.517714754213;3137.1529686984527;3159.589253397058;5132.358455193101;5243.318368612075;5316.494932981365;5391.838244852655;5450.236966824647;5269.262303277535;5321.068812957737;5406.189071639246;5453.563714902808;5456.863578410542;4785.090832741786;4799.13615549201;4799.808007679706;4802.83190088347;4956.2070068789;4934.4572097069295;4941.752912354385;4950.084234416644;4951.405831300249;4958.107540642683;4765.070811191819;4808.927866082012;4809.831655892027;4932.112219800434;4937.506249375069;4845.806167753286;4852.296417019547;4861.368022157097;4861.489543597907;4862.708237505761;4801.495842936476;4823.011282687041;4830.275458681191;4837.298591704219;4842.830500932486;5241.764120614582;5286.947130528684;5296.523312901857;5298.576113910878;5298.947010529922;5716.3426205986425;5779.8555036124435;5784.710764461802;5788.218590490272;5796.565257605696;5727.341355744059;5730.541556675456;5826.650400975955;5871.853203669943;5873.119032145212;5322.414534401213;5403.2705584745945;5422.783088676488;5425.321834770614;5426.158945363475;5731.312242530923;5944.197533332945;5957.076653118774;5958.582899197101;5961.4038596140035;5588.469095435927;5608.691521966331;5623.831285061373;5633.887322253532;5638.971805140948;5725.6850873202375;5726.9713651431475;5729.7708091676695;5730;5735.053716136874;5427.457254274541;5699.658020518782;5716.28546431696;5721.685307308055;5725.627834190847;5473.808416705396;5674.886502269931;5730.083186690193;5749.9712501437225;5824.126381042877;4317.07182955666;4347.065380943112;4348.826046958149;4352.499462561846;4405.7797110145;3869.806509674505;3897.142628621699;3900.2004589059175;3922;3960.821763020671;5411.918821217685;5472.042392581362;5474.863128421821;5476.17857321405;5544;5679.971600141973;5789.53683705311;5792.797252096157;5804.332501762351;5873.530117590582;5518.806841760599;5522.806701765499;5526.171074338881;5556;5564;4988.451270360258;4999.225120106389;5002.224655178453;5003.224500202402;5066.797328106908;5819.272590926134;5820.243368362086;5929.85175370602;5986.640801551834;6007.7596896125415;5849.239598852122;5850.970745146247;5858.150568167677;5911.261092363455;5918.822435326947;5934.347221805684;6046.7278972445465;6055.485283750931;6057.121717350871;6057.363976782374;5593.972030139823;5655.095184770417;5660.264165658438;5736.340320862987;5747.712614369181;5730.054541000855;5769.53843692512;5773.653580785166;5826.970865145647;5837.912431313449;5648.830535083954;5663.377028526941;5664.745086471201;5664.943350566442;5670.489655930986;5441.891162176655;5458.781648734006;5655.547556195576;5662.631928924607;5665.915011274917;5537.501624853782;5572.665640061609;5599.272094627672;5599.720013999202;5677.148427735872;5629.493345598916;5700.515456186271;5705.771769129355;5708;5711.714414279352;5469.371022332482;5522.116461366162;5565.415631358649;5574.888502230014;5575.972120139373 12:40:35 INFO - PROCESS | 27362 | |1;ext.html;581.3140494216825;608.802139304726;628.8270725550476;634.9396807303306;648.5946283572767;32625.51061734073;42946.141077178436;43981.78009109958;44039.77980110099;44040;45404;45769;45770;45807.08385832281;45833.083338333214;8853.42452740573;8991.10088991099;9009.639614415415;9016.729498115066;9018.278537717;8867.157620026088;8895.68865089722;8987.595558199864;8990.460572365679;8991.910080899206;8904.421212621191;8983.685571004984;9030.232430243437;9040.638374465014;9049.909500905005;8898.288136949028;8924.062973387765;8933;8937.150970657776;8942.105789421006;8936.508492032935;9012.81974360509;9018;9019.368644194908;9025.819483610358;41967.370489442685;42458.78770606158;42472;42496.575034249574;42531;3356.3622911646708;3471.114865709253;3510.1751088494184;3770.4155855842387;3893.046203680088;31307.530387043986;31588.842055789803;31812.522812157837;32677.83661081703;33777.662223377694;4239.215745087169;4251.723637963522;4302.096559722462;4312.82748690052;4314.913701725979;339116;339729;340839;341892;344076.2796186028;56183.15725264124;56575;56600.150997735065;56608.43391566114;56663;52500.21249681258;53570.46429535733;56644.71677641585;58457.70771146117;58466;16172.514824555283;16883.746743798853;16885.746713799304;17043.488695339158;17105.914470427568;13142.60572182836;13367.264800436069;13368.866311336762;13413.530526431723;13424.463021479032;14085.647858803612;14473.710525789425;15539.8920215955;15645.217739112999;15995.360185592446;6226.719797609118;6504.349565043458;6637.46900247979;6673.733050678015;6858.177018757781;916.5463095767637;1059.8463222832645;1066.7706443114769;1080.2600218850114;1081.221520505235;32026.199345016095;32321.35357292888;32587.837060815018;32636.510452343235;33326.3334733304;1051.122312868748;1065.9680209593726;1070.0957690751302;1075.510642657589;1133.3766428464312;16591.336346546002;17237.39669111575;17255.137243137793;17425.91287043582;17540.473785786446;476620.61689692026;481778;481863;482456;483954;57196.71401643049;57324.140137897964;57518.42481575214;57566.27301180971;57669;1288.4459682336685;1325.244610571984;1344.7243315120377;1344.7915573086186;1356.6540532164236;30444.391112178077;31280.843595781877;31693.36613267768;31766.364672705953;32459.67540324661;49573.504264956886;50039;50068;50072;50127.24809127793;431159;432521;432612;433552;433556;34540;34874.651253488155;35453.113672158404;37249.25501490009;39598.80200598978;46266.30600541062;46808.297875532575;46989;47198.764006181125;47890.760546197045;39180.60819391884;40182.5844803195;40674;42427.7878610605;43349.78325108354;39962.80018599889;40277;40715.38926916158;41666.37500437435;41961;40496;41630.583694163885;42263.7886810564;42390.78804605957;42493.150136997705;33131.66868331382;36646;36943.445848311756;37022.62977370192;37497.6250237505;28337;28378.2905427366;28438.289042774097;28573.28566785847;28615.570766438104 12:40:35 INFO - PROCESS | 27362 | |2;jquery.html;376.52369752263394;383.81576843115295;386.40879454434713;400.4813766172806;408.70981603061824;17350.91324543377;19623.215071397128;19630.705539416904;19791.703124453146;19820.60358792825;18414.171362288696;19087.713684294748;19279.80720192801;19312.324068657566;19503.21987120517;5597.74810133545;5599.608027438091;5802.564807639423;5851.039901632958;5855.970720146393;5687.573431992597;5741.741621627016;5741.82774516763;5751.10857817037;5767.394423585526;5500.22996780451;5600.775968961237;5660.915086273709;5731.684757338345;5752.626079304852;5664.150377443375;5701.344345400291;5709.942900570983;5710.5717071219615;5711.143328500717;4878.390201224847;4993.251012348141;5022.070916880352;5032.446430892599;5041.344625198737;22287.21702263815;22511.662325065136;22782.77217227823;22872.31383058511;23080.192193273324;2217.2018073493527;2270.2735124760084;2279.247848210087;2339.3332900123555;2435.683361163055;12994.87005129946;13711.588652340446;14258.572242832732;14418.783718244234;14992;1851.0559614596518;1858.711899655542;1909.7326374307609;1911.4934542346289;1964.7544056992876;77951.22048779497;78880.60559697165;79478.60260698717;80446;81038.59480702618;9951.353162044445;9983.855085647998;10067.949660251652;10454.163666906628;10687.198460115522;14430.350634221486;14448.711025779425;14459.349329280207;14463.13221206731;14466.27668616565;7793.142754297023;8170.7957301067945;8195.467294625949;8239.093699693029;8243.340532757366;7846.372290216883;7886.960565197137;7915.208479152154;8119.228673276029;8156.9184308156155;6271.372862713783;6447.548671593037;6508.9023664645065;6515.446187074152;6567.605943643397;1793.9192736326897;1804.2151664026192;1804.877561818036;1821.3898344054626;1851.4630757080565;919.2554031234721;955.2358113509165;1041.5729550884253;1056.1709058389129;1062.9583008651564;19656.70514942277;20180.596388072157;20194;20244.089015994316;20544.897275513526;976.272676855747;986.1666891476691;992.4442312305132;1030.1141018723893;1048.8269435543202;9335.159835614828;11054.336739795637;11351.957534827055;11409.828852567052;11481.483333250024;438306;442431;453867;458510;459036;73747.26252737512;75813.62093189498;76263;76771.61614191893;80177.59911200523;978.5009645080918;1011.5397494140149;1012.4532752313668;1014.0164040880335;1049.4490392543823;16347.836521634632;16880.409185678935;17647.38234161798;17864.821351786315;18136.274549017893;37083.6291637091;37565.81217093897;37959.430608540344;38680.6131938677;38837.41743873787;50322.2451663218;50339.496605033484;50515.49484505108;51595;57549.712251438476;8226.177382261725;8312.459690120122;8482.321414286718;8485.151484851465;8548.401611887108;12933.288669122912;13201.735965280832;13284.335783210994;13295.800562991757;13353.198808071547;11533.942330288295;11747.177697561088;11788.410579471163;11791.410429478321;11824.290542567473;11046.116310694964;11052.407967410785;11153.275037122561;11363.318200907972;11423.428828558373;11970.401479925795;12055.698607534881;12238.204516706386;12356.876431235572;12378.257304561756;7536.208698086622;7711.3830893527265;8217.917820821955;8473.576321183793;8497.300539891923;10952.726181845517;11303;11410.630724313136;11449.313041217554;11538.94230528842 12:40:35 INFO - PROCESS | 27362 | |3;mootools.html;1346.2057386142187;1431.112710119726;1478.9999999999998;1565.4364428805627;1759.4105974498543;8015;8792.384533082679;8966.506842123681;9124.31567632427;9369.906300937006;9204.171624553788;9300.906990930089;9301.302402319836;9303.069693030693;9306.348555601111;2352.094443639203;2373.1219448803968;2385.6421536769535;2398.784109430151;2400.9639855402183;2336.3107883174503;2344.78896899279;2389.2951579284154;2394.2458125690437;2414.9758502414925;2273.1134857405623;2297.6094064009076;2310.041332846875;2329.6272596384583;2337.345543247885;2319.8724070176136;2357.5049239659606;2365.526894621074;2370.9762902370926;2371.964420533702;2313.5257272259314;2317.154238702878;2317.281642690771;2317.7566355532763;2320.2575175943703;8950.507722075283;9102.86345704815;9121.954390228073;9127.954360228223;9129.726108216764;5281.498257665554;5436.565074794046;5454.59090568209;5471.808486702986;5522.337319521643;3621.3481573316794;3634.273145370936;3675.2098298865603;3728.4966529518438;3755.793431361274;1132.473399869065;1140.9600663976803;1143.4968613809897;1156.4795841871191;1168.696139003865;12992.805107923388;13100.803487947689;13113.278769667664;13120.212787232796;13131.409086591126;4586;4642.187617166982;4790.880227994258;4802.27965805125;4848.490908454632;10171.54228059739;10180.083792458714;10182.541785619665;10187.9490602548;10196.38821670702;5460.590455715837;5480.369757477862;5499.285092937893;5526.723663816793;5529.30883639545;4577.908441831211;4722.055588882237;4909.165441874889;5060.165072762953;5191.377034755854;3771.358868992278;3878.9224215515533;3936.252112098692;3955.6835453163676;3958.802059897051;1162.2619636530865;1162.4710756605723;1162.5233654201736;1169.2107827216594;1170.3446070200714;800.7677773445636;918.6049998500575;992.9453880036667;998.9400635961865;1010.2322235101376;6109.419605137505;6131.50947924165;6148.1699970503405;6184.319724830265;6232.407921247474;979.5787811241235;990.4453506036642;991.3159919655415;1001.2890847498358;1026.461107918334;4208.494980602286;4284.4430224070675;4324.0919406924895;4419.425474688334;4440.822367105279;11269.66191014271;11776.293422394683;11778.646640600795;11791.88208117925;11797.587084452003;10703.83944240837;11051.226414150933;11257.831132533018;11594.826077608843;11687.474063667156;8248.46384984974;8334.333253339719;8548.230659240699;8553.315734741205;8558.358123140664;6354.555181137461;6445.16212892321;6459.257185423737;6521.347865213441;6577.934220657732;10212.948935255574;10585.100266477435;10586.41774702368;10591.311564748266;10595.735106622396;10645.859471456093;10663.146948244277;10785.40680262593;10817.350958942488;10889.401082940198;7350.228226036403;7490.925090749023;7589.354904833151;8073.071596766447;8230.176982301722;8747.737567872973;9041.412308199946;9043.095690430904;9061.365704400892;9074.773130671787;7982.680692772224;8079.919200807916;8115.147909469657;8259.132791056853;8339.166083391612;7841.137474877873;7876.133625301327;7885.5662938538935;7999.760007199793;8059;6910.827229319308;6949.409300209539;7000.579965202104;7025.192102908027;7103.112110986127;5231.869203269949;5253.159494480865;5308.946910531;5312.0969435196885;5441.020616289106;5271.367435907716;5318.175682769177;5371.301730774974;5412.161115027177;5598.552115830642 12:40:35 INFO - PROCESS | 27362 | |4;prototype.html;315.4589878358615;327.68434734540824;328.59746810157554;329.78563933443246;335.59560729321163;5268.578513718903;5328.866778330544;5343.358796944362;5347.572194224457;5351.4113447520795;5001.574866136374;5005.274235235888;5144.871378215546;5164.6384753067305;5303.2575439438415;4075.9388609170887;4094.160697057096;4094.651954583864;4097.528784189826;4107.917841643165;4105.158442519277;4115.156392939455;4155.065110350177;4155.439015732883;4169.457970463835;3875.2830726315583;3946.7039972002217;4095.5290141633645;4112.342025275956;4114.80670605524;4081.244969680589;4083.8570650027104;4086.5504794472586;4101.692373072032;4119.217348703737;3641.9453708194396;3646.6535679110443;3647.471116688065;3648.993053820388;3653.1597732521404;5022.723750193738;5055.494450554915;5106.9489305106845;5182.766775495112;5184.896302073975;4679.906401871977;4681.882952926204;4697.084068606623;4702.576768090888;4746.240601503743;5394.32570928634;5452.318460192476;5471.23402723619;5472.616916815825;5480.725963701799;3684.4657524658774;3883;3955.2880481513316;3980.1840622672285;3982.422548730418;5622.859428514279;5626.127950167731;5639.15412688096;5668.57485688575;5686.668465928949;4009.5789942055662;4026.53694825093;4043.7978101094827;4051.1897620476025;4053.574374690674;3847.5190601174854;4069.5726948670554;4085.571015043437;4097.91804163921;4103.507579090468;4605.6776025678555;4658.417697787777;4665.930011049837;4666.976665116653;4672.509386514435;5509.3664228614225;5524.171374293807;5533.944660553343;5535.69911070898;5548.4451554845;1335.946562137523;1396.8812650924583;1412.2797373339465;1413.7596608576566;1417.1922004457567;884.2660591708866;909.5765127575323;911.9042500537348;915.4232833315102;918.807050519385;4732.692374995614;4767.046590681877;4768.6661933665;4776.376032149016;4819.349387832668;4505.43682039745;4975.353204083446;4978.6017118630425;4987.478818960252;5001.224810154432;4704.411948506437;4712.670113092119;4717.504662010508;4734.976325118352;4756.7145971241835;2627.618995245717;2647.788176945878;2648.4305874236748;2648.814582979173;2649.986750066237;4990.251462280687;5132.923006154911;5142.8971420572125;5180.176803642024;5182.611304152204;4937.432535081737;4987.177115775857;5016.08102439118;5041.243813427942;5063.822766203165;5064.341220859004;5135.4094279157625;5153.561947234527;5159.374796938952;5177.550285919949;4672.299155126758;4885.778555361159;4895.657303988829;4901.823562345083;4961.7271050092595;4868.586170175575;4888.633352498506;4909.533594308535;4924.384451943507;4970.850874473772;5124.590032797293;5171.405288391733;5172.353455818023;5175.809563800422;5192.870178245574;3579.6420357963993;3673.669369756628;3691.5201023866725;3697.205100903319;3710.591834898105;4909.159065350494;5328.200769884394;5493.7802487900035;5556.360728654019;5676.2337084493065;5442.972785136049;5468.152436372368;5489.807856724996;5495.3347626401965;5497.835064948058;5287.550558202596;5518.668879867221;5530.668159910419;5536.612437129363;5545.833624991256;5434.23387399089;5452.672839629635;5453.372862120748;5457.972710136424;5462.268865567216;5523.834284971457;5544.611877168721;5567.47109024642;5595.188697638901;5623.634463759842;5074.644774865724;5319.255304257485;5362.892742145057;5472.616916815785;5475.4250803665045 12:40:35 INFO - PROCESS | 27362 | |5;yui.html;684.5892464521288;738.6196109003864;740.5556666000397;761.2752104176592;772.8995230620019;15426.69146617067;16015.919920400382;16016.439424620141;16020.35918563256;16078.115703636295;14057.437702491889;14057.92971035146;14090.929545352285;14094.295285235748;14143.787843182361;782.4522834016198;802.2699343597328;804.3806269172734;804.5936801915025;804.6298702596783;790.1387487638473;795.2047952047952;795.6817273090752;796.9481983671043;797.7447216890597;842.065307508668;843.3632607381419;844.3498506150261;844.7254642241265;844.9915500844975;835.8662613981794;836.8786525953702;838.0739283092187;838.4927119092982;838.5388036579888;619.4827319188483;620.512897375558;621.0125899819263;621.0652967284209;621.2886245249209;13492.12301200419;13576;13594;13636.318184090855;13640.522581709693;12432.564860229848;12648.367581620882;12838.743225135446;12919.483220671162;13247.07270491066;11214.607488737936;11509.884901150965;11941.701457463547;11950.760984780343;11967.461464234131;4331.913361732779;4356.542563030899;4445.044315472189;4455.5098939117;4472.351509031205;71683.28316716818;72132;72951;73218;73729.63135184343;10834.566617335377;10918.611609814578;11002.449877506093;11027.44862756859;11094;19624.215031398584;19715.211391544464;19724.605507889763;19754.802451975585;19809.801901980794;7912.762617121495;8160.061592916772;8220.465669731448;8282.17178282167;8446.282066024334;4507.2112380333965;4678.953210467852;4697.412823397075;4794.616430685537;4825.276208568743;3430.588329400488;3545.308664810389;3547.787132772042;3551.2009797795804;3554.235839294564;567.324883388766;569.8888716700204;575.0540361105957;576.4940475015278;584.2463222443001;636.5162476517787;669.9296573859674;677.4208052115371;690.9309069093151;697.4664381747967;9500.714978550655;9746.512674366253;9891.752706182404;9924.80150396988;9979;670.8088194864538;680.5542369747823;688.449240607512;690.7444245629149;694.5818656745902;4542.159700455426;4829.782659780319;4874.390701162355;4929.137400954819;4933.728644924564;76120.61939690266;118664;119261;123730.38134809268;127229.36385318014;61539.692301538205;93071.53464232771;99784.50107749415;103227.4838625817;103683.48158259311;54371.45628543743;57685.711571441876;61266;72383.6380818103;86654.56672716596;9575.521223938915;10001.599936002478;10187.796244074929;10236.846447303147;10237.74405639865;49941;50062;50460.67398879144;50683.493165069354;51500.742496288774;69319.30680693129;71713;75518.62240688762;76177;76238.61880690783;12672.873271267537;12737.55418560346;12869.420876060412;13051.934740326238;13395.196288222738;13562.525311614047;13671.384787684778;13797.862021380059;14001;14240.145591264558;13097.345132743134;13515.459381624625;13838;14152.78770818418;14318.642033949234;13639.522616708367;14042.15747055139;14091.506797262047;14177.291135443393;14732.337044832793;13182.538611148564;13329.466821327425;13590.79613805774;13798;14052.367643456273;10948.726281843017;11208.55165793359;11301.886981130083;11588.478518466858;11707.941460292644;11515.193936424705;11542.711432214262;11934;12160.75678486443;12200.694982625506 12:40:35 INFO - PROCESS | 27362 | __end_tp_report 12:40:35 INFO - PROCESS | 27362 | __start_cc_report 12:40:35 INFO - PROCESS | 27362 | _x_x_mozilla_cycle_collect,975 12:40:35 INFO - PROCESS | 27362 | __end_cc_report 12:40:35 INFO - PROCESS | 27362 | __startTimestamp1475091635292__endTimestamp 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | ------- Summary: start ------- 12:40:35 INFO - PROCESS | 27362 | Number of tests: 6 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#0] dojo.html Cycles:165 Average:5346.02 Median:5565.42 stddev:619.42 (11.1%) stddev-sans-first:594.83 12:40:35 INFO - PROCESS | 27362 | Values: 3061.5 3106.3 3111.5 3137.2 3159.6 5132.4 5243.3 5316.5 5391.8 5450.2 5269.3 5321.1 5406.2 5453.6 5456.9 4785.1 4799.1 4799.8 4802.8 4956.2 4934.5 4941.8 4950.1 4951.4 4958.1 4765.1 4808.9 4809.8 4932.1 4937.5 4845.8 4852.3 4861.4 4861.5 4862.7 4801.5 4823.0 4830.3 4837.3 4842.8 5241.8 5286.9 5296.5 5298.6 5298.9 5716.3 5779.9 5784.7 5788.2 5796.6 5727.3 5730.5 5826.7 5871.9 5873.1 5322.4 5403.3 5422.8 5425.3 5426.2 5731.3 5944.2 5957.1 5958.6 5961.4 5588.5 5608.7 5623.8 5633.9 5639.0 5725.7 5727.0 5729.8 5730.0 5735.1 5427.5 5699.7 5716.3 5721.7 5725.6 5473.8 5674.9 5730.1 5750.0 5824.1 4317.1 4347.1 4348.8 4352.5 4405.8 3869.8 3897.1 3900.2 3922.0 3960.8 5411.9 5472.0 5474.9 5476.2 5544.0 5680.0 5789.5 5792.8 5804.3 5873.5 5518.8 5522.8 5526.2 5556.0 5564.0 4988.5 4999.2 5002.2 5003.2 5066.8 5819.3 5820.2 5929.9 5986.6 6007.8 5849.2 5851.0 5858.2 5911.3 5918.8 5934.3 6046.7 6055.5 6057.1 6057.4 5594.0 5655.1 5660.3 5736.3 5747.7 5730.1 5769.5 5773.7 5827.0 5837.9 5648.8 5663.4 5664.7 5664.9 5670.5 5441.9 5458.8 5655.5 5662.6 5665.9 5537.5 5572.7 5599.3 5599.7 5677.1 5629.5 5700.5 5705.8 5708.0 5711.7 5469.4 5522.1 5565.4 5574.9 5576.0 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#1] ext.html Cycles:180 Average:58303.79 Median:42465.39 stddev:111617.09 (262.8%) stddev-sans-first:111846.06 12:40:35 INFO - PROCESS | 27362 | Values: 581.3 608.8 628.8 634.9 648.6 32625.5 42946.1 43981.8 44039.8 44040.0 45404.0 45769.0 45770.0 45807.1 45833.1 8853.4 8991.1 9009.6 9016.7 9018.3 8867.2 8895.7 8987.6 8990.5 8991.9 8904.4 8983.7 9030.2 9040.6 9049.9 8898.3 8924.1 8933.0 8937.2 8942.1 8936.5 9012.8 9018.0 9019.4 9025.8 41967.4 42458.8 42472.0 42496.6 42531.0 3356.4 3471.1 3510.2 3770.4 3893.0 31307.5 31588.8 31812.5 32677.8 33777.7 4239.2 4251.7 4302.1 4312.8 4314.9 339116.0 339729.0 340839.0 341892.0 344076.3 56183.2 56575.0 56600.2 56608.4 56663.0 52500.2 53570.5 56644.7 58457.7 58466.0 16172.5 16883.7 16885.7 17043.5 17105.9 13142.6 13367.3 13368.9 13413.5 13424.5 14085.6 14473.7 15539.9 15645.2 15995.4 6226.7 6504.3 6637.5 6673.7 6858.2 916.5 1059.8 1066.8 1080.3 1081.2 32026.2 32321.4 32587.8 32636.5 33326.3 1051.1 1066.0 1070.1 1075.5 1133.4 16591.3 17237.4 17255.1 17425.9 17540.5 476620.6 481778.0 481863.0 482456.0 483954.0 57196.7 57324.1 57518.4 57566.3 57669.0 1288.4 1325.2 1344.7 1344.8 1356.7 30444.4 31280.8 31693.4 31766.4 32459.7 49573.5 50039.0 50068.0 50072.0 50127.2 431159.0 432521.0 432612.0 433552.0 433556.0 34540.0 34874.7 35453.1 37249.3 39598.8 46266.3 46808.3 46989.0 47198.8 47890.8 39180.6 40182.6 40674.0 42427.8 43349.8 39962.8 40277.0 40715.4 41666.4 41961.0 40496.0 41630.6 42263.8 42390.8 42493.2 33131.7 36646.0 36943.4 37022.6 37497.6 28337.0 28378.3 28438.3 28573.3 28615.6 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#2] jquery.html Cycles:180 Average:27248.66 Median:19759.66 stddev:74063.69 (374.8%) stddev-sans-first:74243.97 12:40:35 INFO - PROCESS | 27362 | Values: 376.5 383.8 386.4 400.5 408.7 17350.9 19623.2 19630.7 19791.7 19820.6 18414.2 19087.7 19279.8 19312.3 19503.2 5597.7 5599.6 5802.6 5851.0 5856.0 5687.6 5741.7 5741.8 5751.1 5767.4 5500.2 5600.8 5660.9 5731.7 5752.6 5664.2 5701.3 5709.9 5710.6 5711.1 4878.4 4993.3 5022.1 5032.4 5041.3 22287.2 22511.7 22782.8 22872.3 23080.2 2217.2 2270.3 2279.2 2339.3 2435.7 12994.9 13711.6 14258.6 14418.8 14992.0 1851.1 1858.7 1909.7 1911.5 1964.8 77951.2 78880.6 79478.6 80446.0 81038.6 9951.4 9983.9 10067.9 10454.2 10687.2 14430.4 14448.7 14459.3 14463.1 14466.3 7793.1 8170.8 8195.5 8239.1 8243.3 7846.4 7887.0 7915.2 8119.2 8156.9 6271.4 6447.5 6508.9 6515.4 6567.6 1793.9 1804.2 1804.9 1821.4 1851.5 919.3 955.2 1041.6 1056.2 1063.0 19656.7 20180.6 20194.0 20244.1 20544.9 976.3 986.2 992.4 1030.1 1048.8 9335.2 11054.3 11352.0 11409.8 11481.5 438306.0 442431.0 453867.0 458510.0 459036.0 73747.3 75813.6 76263.0 76771.6 80177.6 978.5 1011.5 1012.5 1014.0 1049.4 16347.8 16880.4 17647.4 17864.8 18136.3 37083.6 37565.8 37959.4 38680.6 38837.4 50322.2 50339.5 50515.5 51595.0 57549.7 8226.2 8312.5 8482.3 8485.2 8548.4 12933.3 13201.7 13284.3 13295.8 13353.2 11533.9 11747.2 11788.4 11791.4 11824.3 11046.1 11052.4 11153.3 11363.3 11423.4 11970.4 12055.7 12238.2 12356.9 12378.3 7536.2 7711.4 8217.9 8473.6 8497.3 10952.7 11303.0 11410.6 11449.3 11538.9 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#3] mootools.html Cycles:180 Average:6008.82 Median:4682.12 stddev:3460.35 (73.9%) stddev-sans-first:3452.31 12:40:35 INFO - PROCESS | 27362 | Values: 1346.2 1431.1 1479.0 1565.4 1759.4 8015.0 8792.4 8966.5 9124.3 9369.9 9204.2 9300.9 9301.3 9303.1 9306.3 2352.1 2373.1 2385.6 2398.8 2401.0 2336.3 2344.8 2389.3 2394.2 2415.0 2273.1 2297.6 2310.0 2329.6 2337.3 2319.9 2357.5 2365.5 2371.0 2372.0 2313.5 2317.2 2317.3 2317.8 2320.3 8950.5 9102.9 9122.0 9128.0 9129.7 5281.5 5436.6 5454.6 5471.8 5522.3 3621.3 3634.3 3675.2 3728.5 3755.8 1132.5 1141.0 1143.5 1156.5 1168.7 12992.8 13100.8 13113.3 13120.2 13131.4 4586.0 4642.2 4790.9 4802.3 4848.5 10171.5 10180.1 10182.5 10187.9 10196.4 5460.6 5480.4 5499.3 5526.7 5529.3 4577.9 4722.1 4909.2 5060.2 5191.4 3771.4 3878.9 3936.3 3955.7 3958.8 1162.3 1162.5 1162.5 1169.2 1170.3 800.8 918.6 992.9 998.9 1010.2 6109.4 6131.5 6148.2 6184.3 6232.4 979.6 990.4 991.3 1001.3 1026.5 4208.5 4284.4 4324.1 4419.4 4440.8 11269.7 11776.3 11778.6 11791.9 11797.6 10703.8 11051.2 11257.8 11594.8 11687.5 8248.5 8334.3 8548.2 8553.3 8558.4 6354.6 6445.2 6459.3 6521.3 6577.9 10212.9 10585.1 10586.4 10591.3 10595.7 10645.9 10663.1 10785.4 10817.4 10889.4 7350.2 7490.9 7589.4 8073.1 8230.2 8747.7 9041.4 9043.1 9061.4 9074.8 7982.7 8079.9 8115.1 8259.1 8339.2 7841.1 7876.1 7885.6 7999.8 8059.0 6910.8 6949.4 7000.6 7025.2 7103.1 5231.9 5253.2 5308.9 5312.1 5441.0 5271.4 5318.2 5371.3 5412.2 5598.6 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#4] prototype.html Cycles:180 Average:4438.89 Median:4949.58 stddev:1280.87 (25.9%) stddev-sans-first:1246.51 12:40:35 INFO - PROCESS | 27362 | Values: 315.5 327.7 328.6 329.8 335.6 5268.6 5328.9 5343.4 5347.6 5351.4 5001.6 5005.3 5144.9 5164.6 5303.3 4075.9 4094.2 4094.7 4097.5 4107.9 4105.2 4115.2 4155.1 4155.4 4169.5 3875.3 3946.7 4095.5 4112.3 4114.8 4081.2 4083.9 4086.6 4101.7 4119.2 3641.9 3646.7 3647.5 3649.0 3653.2 5022.7 5055.5 5106.9 5182.8 5184.9 4679.9 4681.9 4697.1 4702.6 4746.2 5394.3 5452.3 5471.2 5472.6 5480.7 3684.5 3883.0 3955.3 3980.2 3982.4 5622.9 5626.1 5639.2 5668.6 5686.7 4009.6 4026.5 4043.8 4051.2 4053.6 3847.5 4069.6 4085.6 4097.9 4103.5 4605.7 4658.4 4665.9 4667.0 4672.5 5509.4 5524.2 5533.9 5535.7 5548.4 1335.9 1396.9 1412.3 1413.8 1417.2 884.3 909.6 911.9 915.4 918.8 4732.7 4767.0 4768.7 4776.4 4819.3 4505.4 4975.4 4978.6 4987.5 5001.2 4704.4 4712.7 4717.5 4735.0 4756.7 2627.6 2647.8 2648.4 2648.8 2650.0 4990.3 5132.9 5142.9 5180.2 5182.6 4937.4 4987.2 5016.1 5041.2 5063.8 5064.3 5135.4 5153.6 5159.4 5177.6 4672.3 4885.8 4895.7 4901.8 4961.7 4868.6 4888.6 4909.5 4924.4 4970.9 5124.6 5171.4 5172.4 5175.8 5192.9 3579.6 3673.7 3691.5 3697.2 3710.6 4909.2 5328.2 5493.8 5556.4 5676.2 5443.0 5468.2 5489.8 5495.3 5497.8 5287.6 5518.7 5530.7 5536.6 5545.8 5434.2 5452.7 5453.4 5458.0 5462.3 5523.8 5544.6 5567.5 5595.2 5623.6 5074.6 5319.3 5362.9 5472.6 5475.4 12:40:35 INFO - PROCESS | 27362 | 12:40:35 INFO - PROCESS | 27362 | [#5] yui.html Cycles:180 Average:19756.92 Median:4524.69 stddev:28306.22 (625.6%) stddev-sans-first:28349.40 12:40:35 INFO - PROCESS | 27362 | Values: 684.6 738.6 740.6 761.3 772.9 15426.7 16015.9 16016.4 16020.4 16078.1 14057.4 14057.9 14090.9 14094.3 14143.8 782.5 802.3 804.4 804.6 804.6 790.1 795.2 795.7 796.9 797.7 842.1 843.4 844.3 844.7 845.0 835.9 836.9 838.1 838.5 838.5 619.5 620.5 621.0 621.1 621.3 13492.1 13576.0 13594.0 13636.3 13640.5 12432.6 12648.4 12838.7 12919.5 13247.1 11214.6 11509.9 11941.7 11950.8 11967.5 4331.9 4356.5 4445.0 4455.5 4472.4 71683.3 72132.0 72951.0 73218.0 73729.6 10834.6 10918.6 11002.4 11027.4 11094.0 19624.2 19715.2 19724.6 19754.8 19809.8 7912.8 8160.1 8220.5 8282.2 8446.3 4507.2 4679.0 4697.4 4794.6 4825.3 3430.6 3545.3 3547.8 3551.2 3554.2 567.3 569.9 575.1 576.5 584.2 636.5 669.9 677.4 690.9 697.5 9500.7 9746.5 9891.8 9924.8 9979.0 670.8 680.6 688.4 690.7 694.6 4542.2 4829.8 4874.4 4929.1 4933.7 76120.6 118664.0 119261.0 123730.4 127229.4 61539.7 93071.5 99784.5 103227.5 103683.5 54371.5 57685.7 61266.0 72383.6 86654.6 9575.5 10001.6 10187.8 10236.8 10237.7 49941.0 50062.0 50460.7 50683.5 51500.7 69319.3 71713.0 75518.6 76177.0 76238.6 12672.9 12737.6 12869.4 13051.9 13395.2 13562.5 13671.4 13797.9 14001.0 14240.1 13097.3 13515.5 13838.0 14152.8 14318.6 13639.5 14042.2 14091.5 14177.3 14732.3 13182.5 13329.5 13590.8 13798.0 14052.4 10948.7 11208.6 11301.9 11588.5 11707.9 11515.2 11542.7 11934.0 12160.8 12200.7 12:40:35 INFO - PROCESS | 27362 | -------- Summary: end -------- 12:40:35 INFO - PROCESS | 27362 | 12:40:36 INFO - TEST-INFO | 27362: exit 0 12:40:36 INFO - TEST-OK | dromaeo_css | took 1117097ms 12:40:36 INFO - TEST-START | kraken 12:40:36 INFO - operating with platform_type : linux_ 12:40:36 INFO - Initialising browser for kraken test... 12:40:36 INFO - TEST-INFO | started process 27673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiBp2OQ/profile http://localhost:52170/getInfo.html) 12:40:40 INFO - PROCESS | 27673 | __metrics Screen width/height:1600/1200 12:40:40 INFO - PROCESS | 27673 | colorDepth:24 12:40:40 INFO - PROCESS | 27673 | Browser inner width/height: 1024/697 12:40:40 INFO - PROCESS | 27673 | __metrics 12:40:41 INFO - PROCESS | 27673 | 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:40:41 INFO - PROCESS | 27673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:41 INFO - PROCESS | 27673 | console.error: PushService: 12:40:41 INFO - PROCESS | 27673 | stateChangeProcessEnqueue: Error transitioning state 12:40:41 INFO - PROCESS | 27673 | UnknownError 12:40:42 INFO - TEST-INFO | 27673: exit 0 12:40:42 INFO - Browser initialized. 12:40:42 INFO - Running cycle 1/1 for kraken test... 12:40:42 INFO - TEST-INFO | started process 27756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiBp2OQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:54 INFO - PROCESS | 27756 | RSS: Main: 173625344 12:40:54 INFO - PROCESS | 27756 | 12:40:57 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52170/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:58 INFO - PROCESS | 27756 | RSS: Main: 232251392 12:40:58 INFO - PROCESS | 27756 | 12:41:00 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52170/tests/kraken/driver.html?testName=audio-dft) 12:41:01 INFO - PROCESS | 27756 | RSS: Main: 216625152 12:41:01 INFO - PROCESS | 27756 | 12:41:04 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52170/tests/kraken/driver.html?testName=audio-fft) 12:41:05 INFO - PROCESS | 27756 | RSS: Main: 298590208 12:41:05 INFO - PROCESS | 27756 | 12:41:07 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52170/tests/kraken/driver.html?testName=audio-oscillator) 12:41:07 INFO - PROCESS | 27756 | RSS: Main: 208969728 12:41:07 INFO - PROCESS | 27756 | 12:41:09 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:41:10 INFO - PROCESS | 27756 | RSS: Main: 212336640 12:41:10 INFO - PROCESS | 27756 | 12:41:13 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52170/tests/kraken/driver.html?testName=imaging-darkroom) 12:41:14 INFO - PROCESS | 27756 | RSS: Main: 249221120 12:41:14 INFO - PROCESS | 27756 | 12:41:17 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52170/tests/kraken/driver.html?testName=imaging-desaturate) 12:41:18 INFO - PROCESS | 27756 | RSS: Main: 248127488 12:41:18 INFO - PROCESS | 27756 | 12:41:20 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52170/tests/kraken/driver.html?testName=json-parse-financial) 12:41:21 INFO - PROCESS | 27756 | RSS: Main: 248107008 12:41:21 INFO - PROCESS | 27756 | 12:41:22 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:41:23 INFO - PROCESS | 27756 | RSS: Main: 210489344 12:41:23 INFO - PROCESS | 27756 | 12:41:25 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:41:25 INFO - PROCESS | 27756 | RSS: Main: 218546176 12:41:25 INFO - PROCESS | 27756 | 12:41:27 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:41:28 INFO - PROCESS | 27756 | RSS: Main: 222564352 12:41:28 INFO - PROCESS | 27756 | 12:41:31 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:31 INFO - PROCESS | 27756 | RSS: Main: 216584192 12:41:31 INFO - PROCESS | 27756 | 12:41:34 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:35 INFO - PROCESS | 27756 | RSS: Main: 221540352 12:41:35 INFO - PROCESS | 27756 | 12:41:36 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:52170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52170/tests/kraken/driver.html?testName=ai-astar) 12:41:37 INFO - PROCESS | 27756 | RSS: Main: 272601088 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | __start_tp_report 12:41:37 INFO - PROCESS | 27756 | _x_x_mozilla_page_load 12:41:37 INFO - PROCESS | 27756 | _x_x_mozilla_page_load_details 12:41:37 INFO - PROCESS | 27756 | |i|pagename|runs| 12:41:37 INFO - PROCESS | 27756 | |0;ai-astar;108;109;109;109;110;110;110;113;110;109 12:41:37 INFO - PROCESS | 27756 | |1;audio-beat-detection;148;124;120;157;122;117;119;116;152;118 12:41:37 INFO - PROCESS | 27756 | |2;audio-dft;162;160;163;162;162;162;163;162;162;164 12:41:37 INFO - PROCESS | 27756 | |3;audio-fft;76;75;75;119;76;76;77;77;105;77 12:41:37 INFO - PROCESS | 27756 | |4;audio-oscillator;83;83;116;84;82;82;102;82;82;116 12:41:37 INFO - PROCESS | 27756 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;118;118;118 12:41:37 INFO - PROCESS | 27756 | |6;imaging-darkroom;146;145;145;146;146;146;145;145;145;147 12:41:37 INFO - PROCESS | 27756 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;96;96 12:41:37 INFO - PROCESS | 27756 | |8;json-parse-financial;52;50;50;50;50;52;50;50;51;51 12:41:37 INFO - PROCESS | 27756 | |9;json-stringify-tinderbox;59;59;59;59;59;58;58;59;59;59 12:41:37 INFO - PROCESS | 27756 | |10;stanford-crypto-aes;79;87;81;84;78;83;79;79;78;83 12:41:37 INFO - PROCESS | 27756 | |11;stanford-crypto-ccm;125;126;128;122;135;130;137;124;164;128 12:41:37 INFO - PROCESS | 27756 | |12;stanford-crypto-pbkdf2;164;169;164;163;164;166;164;164;164;162 12:41:37 INFO - PROCESS | 27756 | |13;stanford-crypto-sha256-iterative;67;66;65;63;63;65;67;65;64;64 12:41:37 INFO - PROCESS | 27756 | __end_tp_report 12:41:37 INFO - PROCESS | 27756 | __start_cc_report 12:41:37 INFO - PROCESS | 27756 | _x_x_mozilla_cycle_collect,1599 12:41:37 INFO - PROCESS | 27756 | __end_cc_report 12:41:37 INFO - PROCESS | 27756 | __startTimestamp1475091697062__endTimestamp 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | ------- Summary: start ------- 12:41:37 INFO - PROCESS | 27756 | Number of tests: 14 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 12:41:37 INFO - PROCESS | 27756 | Values: 108.0 109.0 109.0 109.0 110.0 110.0 110.0 113.0 110.0 109.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:123.00 stddev:16.20 (13.2%) stddev-sans-first:15.71 12:41:37 INFO - PROCESS | 27756 | Values: 148.0 124.0 120.0 157.0 122.0 117.0 119.0 116.0 152.0 118.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 12:41:37 INFO - PROCESS | 27756 | Values: 162.0 160.0 163.0 162.0 162.0 162.0 163.0 162.0 162.0 164.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.50 (20.4%) stddev-sans-first:16.21 12:41:37 INFO - PROCESS | 27756 | Values: 76.0 75.0 75.0 119.0 76.0 76.0 77.0 77.0 105.0 77.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.42 (17.6%) stddev-sans-first:14.99 12:41:37 INFO - PROCESS | 27756 | Values: 83.0 83.0 116.0 84.0 82.0 82.0 102.0 82.0 82.0 116.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 12:41:37 INFO - PROCESS | 27756 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:41:37 INFO - PROCESS | 27756 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 147.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 12:41:37 INFO - PROCESS | 27756 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.73 12:41:37 INFO - PROCESS | 27756 | Values: 52.0 50.0 50.0 50.0 50.0 52.0 50.0 50.0 51.0 51.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 12:41:37 INFO - PROCESS | 27756 | Values: 59.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 59.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:82.00 stddev:3.03 (3.7%) stddev-sans-first:3.12 12:41:37 INFO - PROCESS | 27756 | Values: 79.0 87.0 81.0 84.0 78.0 83.0 79.0 79.0 78.0 83.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:129.00 stddev:12.22 (9.5%) stddev-sans-first:12.70 12:41:37 INFO - PROCESS | 27756 | Values: 125.0 126.0 128.0 122.0 135.0 130.0 137.0 124.0 164.0 128.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 12:41:37 INFO - PROCESS | 27756 | Values: 164.0 169.0 164.0 163.0 164.0 166.0 164.0 164.0 164.0 162.0 12:41:37 INFO - PROCESS | 27756 | 12:41:37 INFO - PROCESS | 27756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.32 12:41:37 INFO - PROCESS | 27756 | Values: 67.0 66.0 65.0 63.0 63.0 65.0 67.0 65.0 64.0 64.0 12:41:37 INFO - PROCESS | 27756 | -------- Summary: end -------- 12:41:37 INFO - PROCESS | 27756 | 12:41:38 INFO - TEST-INFO | 27756: exit 0 12:41:38 INFO - TEST-OK | kraken | took 61951ms 12:41:38 INFO - SUITE-END | took 1179s 12:41:38 INFO - Completed test suite (00:19:39) 12:41:38 INFO - javascript benchmark 12:41:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.51015837466, 3106.2700265437634, 3111.517714754213, 3137.1529686984527, 3159.589253397058, 5132.358455193101, 5243.318368612075, 5316.494932981365, 5391.838244852655, 5450.236966824647, 5269.262303277535, 5321.068812957737, 5406.189071639246, 5453.563714902808, 5456.863578410542, 4785.090832741786, 4799.13615549201, 4799.808007679706, 4802.83190088347, 4956.2070068789, 4934.4572097069295, 4941.752912354385, 4950.084234416644, 4951.405831300249, 4958.107540642683, 4765.070811191819, 4808.927866082012, 4809.831655892027, 4932.112219800434, 4937.506249375069, 4845.806167753286, 4852.296417019547, 4861.368022157097, 4861.489543597907, 4862.708237505761, 4801.495842936476, 4823.011282687041, 4830.275458681191, 4837.298591704219, 4842.830500932486, 5241.764120614582, 5286.947130528684, 5296.523312901857, 5298.576113910878, 5298.947010529922, 5716.3426205986425, 5779.8555036124435, 5784.710764461802, 5788.218590490272, 5796.565257605696, 5727.341355744059, 5730.541556675456, 5826.650400975955, 5871.853203669943, 5873.119032145212, 5322.414534401213, 5403.2705584745945, 5422.783088676488, 5425.321834770614, 5426.158945363475, 5731.312242530923, 5944.197533332945, 5957.076653118774, 5958.582899197101, 5961.4038596140035, 5588.469095435927, 5608.691521966331, 5623.831285061373, 5633.887322253532, 5638.971805140948, 5725.6850873202375, 5726.9713651431475, 5729.7708091676695, 5730.0, 5735.053716136874, 5427.457254274541, 5699.658020518782, 5716.28546431696, 5721.685307308055, 5725.627834190847, 5473.808416705396, 5674.886502269931, 5730.083186690193, 5749.9712501437225, 5824.126381042877, 4317.07182955666, 4347.065380943112, 4348.826046958149, 4352.499462561846, 4405.7797110145, 3869.806509674505, 3897.142628621699, 3900.2004589059175, 3922.0, 3960.821763020671, 5411.918821217685, 5472.042392581362, 5474.863128421821, 5476.17857321405, 5544.0, 5679.971600141973, 5789.53683705311, 5792.797252096157, 5804.332501762351, 5873.530117590582, 5518.806841760599, 5522.806701765499, 5526.171074338881, 5556.0, 5564.0, 4988.451270360258, 4999.225120106389, 5002.224655178453, 5003.224500202402, 5066.797328106908, 5819.272590926134, 5820.243368362086, 5929.85175370602, 5986.640801551834, 6007.7596896125415, 5849.239598852122, 5850.970745146247, 5858.150568167677, 5911.261092363455, 5918.822435326947, 5934.347221805684, 6046.7278972445465, 6055.485283750931, 6057.121717350871, 6057.363976782374, 5593.972030139823, 5655.095184770417, 5660.264165658438, 5736.340320862987, 5747.712614369181, 5730.054541000855, 5769.53843692512, 5773.653580785166, 5826.970865145647, 5837.912431313449, 5648.830535083954, 5663.377028526941, 5664.745086471201, 5664.943350566442, 5670.489655930986, 5441.891162176655, 5458.781648734006, 5655.547556195576, 5662.631928924607, 5665.915011274917, 5537.501624853782, 5572.665640061609, 5599.272094627672, 5599.720013999202, 5677.148427735872, 5629.493345598916, 5700.515456186271, 5705.771769129355, 5708.0, 5711.714414279352, 5469.371022332482, 5522.116461366162, 5565.415631358649, 5574.888502230014, 5575.972120139373], "value": 5303.59503047456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.3140494216825, 608.802139304726, 628.8270725550476, 634.9396807303306, 648.5946283572767, 32625.51061734073, 42946.141077178436, 43981.78009109958, 44039.77980110099, 44040.0, 45404.0, 45769.0, 45770.0, 45807.08385832281, 45833.083338333214, 8853.42452740573, 8991.10088991099, 9009.639614415415, 9016.729498115066, 9018.278537717, 8867.157620026088, 8895.68865089722, 8987.595558199864, 8990.460572365679, 8991.910080899206, 8904.421212621191, 8983.685571004984, 9030.232430243437, 9040.638374465014, 9049.909500905005, 8898.288136949028, 8924.062973387765, 8933.0, 8937.150970657776, 8942.105789421006, 8936.508492032935, 9012.81974360509, 9018.0, 9019.368644194908, 9025.819483610358, 41967.370489442685, 42458.78770606158, 42472.0, 42496.575034249574, 42531.0, 3356.3622911646708, 3471.114865709253, 3510.1751088494184, 3770.4155855842387, 3893.046203680088, 31307.530387043986, 31588.842055789803, 31812.522812157837, 32677.83661081703, 33777.662223377694, 4239.215745087169, 4251.723637963522, 4302.096559722462, 4312.82748690052, 4314.913701725979, 339116.0, 339729.0, 340839.0, 341892.0, 344076.2796186028, 56183.15725264124, 56575.0, 56600.150997735065, 56608.43391566114, 56663.0, 52500.21249681258, 53570.46429535733, 56644.71677641585, 58457.70771146117, 58466.0, 16172.514824555283, 16883.746743798853, 16885.746713799304, 17043.488695339158, 17105.914470427568, 13142.60572182836, 13367.264800436069, 13368.866311336762, 13413.530526431723, 13424.463021479032, 14085.647858803612, 14473.710525789425, 15539.8920215955, 15645.217739112999, 15995.360185592446, 6226.719797609118, 6504.349565043458, 6637.46900247979, 6673.733050678015, 6858.177018757781, 916.5463095767637, 1059.8463222832645, 1066.7706443114769, 1080.2600218850114, 1081.221520505235, 32026.199345016095, 32321.35357292888, 32587.837060815018, 32636.510452343235, 33326.3334733304, 1051.122312868748, 1065.9680209593726, 1070.0957690751302, 1075.510642657589, 1133.3766428464312, 16591.336346546002, 17237.39669111575, 17255.137243137793, 17425.91287043582, 17540.473785786446, 476620.61689692026, 481778.0, 481863.0, 482456.0, 483954.0, 57196.71401643049, 57324.140137897964, 57518.42481575214, 57566.27301180971, 57669.0, 1288.4459682336685, 1325.244610571984, 1344.7243315120377, 1344.7915573086186, 1356.6540532164236, 30444.391112178077, 31280.843595781877, 31693.36613267768, 31766.364672705953, 32459.67540324661, 49573.504264956886, 50039.0, 50068.0, 50072.0, 50127.24809127793, 431159.0, 432521.0, 432612.0, 433552.0, 433556.0, 34540.0, 34874.651253488155, 35453.113672158404, 37249.25501490009, 39598.80200598978, 46266.30600541062, 46808.297875532575, 46989.0, 47198.764006181125, 47890.760546197045, 39180.60819391884, 40182.5844803195, 40674.0, 42427.7878610605, 43349.78325108354, 39962.80018599889, 40277.0, 40715.38926916158, 41666.37500437435, 41961.0, 40496.0, 41630.583694163885, 42263.7886810564, 42390.78804605957, 42493.150136997705, 33131.66868331382, 36646.0, 36943.445848311756, 37022.62977370192, 37497.6250237505, 28337.0, 28378.2905427366, 28438.289042774097, 28573.28566785847, 28615.570766438104], "value": 20000.099460636608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.52369752263394, 383.81576843115295, 386.40879454434713, 400.4813766172806, 408.70981603061824, 17350.91324543377, 19623.215071397128, 19630.705539416904, 19791.703124453146, 19820.60358792825, 18414.171362288696, 19087.713684294748, 19279.80720192801, 19312.324068657566, 19503.21987120517, 5597.74810133545, 5599.608027438091, 5802.564807639423, 5851.039901632958, 5855.970720146393, 5687.573431992597, 5741.741621627016, 5741.82774516763, 5751.10857817037, 5767.394423585526, 5500.22996780451, 5600.775968961237, 5660.915086273709, 5731.684757338345, 5752.626079304852, 5664.150377443375, 5701.344345400291, 5709.942900570983, 5710.5717071219615, 5711.143328500717, 4878.390201224847, 4993.251012348141, 5022.070916880352, 5032.446430892599, 5041.344625198737, 22287.21702263815, 22511.662325065136, 22782.77217227823, 22872.31383058511, 23080.192193273324, 2217.2018073493527, 2270.2735124760084, 2279.247848210087, 2339.3332900123555, 2435.683361163055, 12994.87005129946, 13711.588652340446, 14258.572242832732, 14418.783718244234, 14992.0, 1851.0559614596518, 1858.711899655542, 1909.7326374307609, 1911.4934542346289, 1964.7544056992876, 77951.22048779497, 78880.60559697165, 79478.60260698717, 80446.0, 81038.59480702618, 9951.353162044445, 9983.855085647998, 10067.949660251652, 10454.163666906628, 10687.198460115522, 14430.350634221486, 14448.711025779425, 14459.349329280207, 14463.13221206731, 14466.27668616565, 7793.142754297023, 8170.7957301067945, 8195.467294625949, 8239.093699693029, 8243.340532757366, 7846.372290216883, 7886.960565197137, 7915.208479152154, 8119.228673276029, 8156.9184308156155, 6271.372862713783, 6447.548671593037, 6508.9023664645065, 6515.446187074152, 6567.605943643397, 1793.9192736326897, 1804.2151664026192, 1804.877561818036, 1821.3898344054626, 1851.4630757080565, 919.2554031234721, 955.2358113509165, 1041.5729550884253, 1056.1709058389129, 1062.9583008651564, 19656.70514942277, 20180.596388072157, 20194.0, 20244.089015994316, 20544.897275513526, 976.272676855747, 986.1666891476691, 992.4442312305132, 1030.1141018723893, 1048.8269435543202, 9335.159835614828, 11054.336739795637, 11351.957534827055, 11409.828852567052, 11481.483333250024, 438306.0, 442431.0, 453867.0, 458510.0, 459036.0, 73747.26252737512, 75813.62093189498, 76263.0, 76771.61614191893, 80177.59911200523, 978.5009645080918, 1011.5397494140149, 1012.4532752313668, 1014.0164040880335, 1049.4490392543823, 16347.836521634632, 16880.409185678935, 17647.38234161798, 17864.821351786315, 18136.274549017893, 37083.6291637091, 37565.81217093897, 37959.430608540344, 38680.6131938677, 38837.41743873787, 50322.2451663218, 50339.496605033484, 50515.49484505108, 51595.0, 57549.712251438476, 8226.177382261725, 8312.459690120122, 8482.321414286718, 8485.151484851465, 8548.401611887108, 12933.288669122912, 13201.735965280832, 13284.335783210994, 13295.800562991757, 13353.198808071547, 11533.942330288295, 11747.177697561088, 11788.410579471163, 11791.410429478321, 11824.290542567473, 11046.116310694964, 11052.407967410785, 11153.275037122561, 11363.318200907972, 11423.428828558373, 11970.401479925795, 12055.698607534881, 12238.204516706386, 12356.876431235572, 12378.257304561756, 7536.208698086622, 7711.3830893527265, 8217.917820821955, 8473.576321183793, 8497.300539891923, 10952.726181845517, 11303.0, 11410.630724313136, 11449.313041217554, 11538.94230528842], "value": 9158.340813732137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.2057386142187, 1431.112710119726, 1478.9999999999998, 1565.4364428805627, 1759.4105974498543, 8015.0, 8792.384533082679, 8966.506842123681, 9124.31567632427, 9369.906300937006, 9204.171624553788, 9300.906990930089, 9301.302402319836, 9303.069693030693, 9306.348555601111, 2352.094443639203, 2373.1219448803968, 2385.6421536769535, 2398.784109430151, 2400.9639855402183, 2336.3107883174503, 2344.78896899279, 2389.2951579284154, 2394.2458125690437, 2414.9758502414925, 2273.1134857405623, 2297.6094064009076, 2310.041332846875, 2329.6272596384583, 2337.345543247885, 2319.8724070176136, 2357.5049239659606, 2365.526894621074, 2370.9762902370926, 2371.964420533702, 2313.5257272259314, 2317.154238702878, 2317.281642690771, 2317.7566355532763, 2320.2575175943703, 8950.507722075283, 9102.86345704815, 9121.954390228073, 9127.954360228223, 9129.726108216764, 5281.498257665554, 5436.565074794046, 5454.59090568209, 5471.808486702986, 5522.337319521643, 3621.3481573316794, 3634.273145370936, 3675.2098298865603, 3728.4966529518438, 3755.793431361274, 1132.473399869065, 1140.9600663976803, 1143.4968613809897, 1156.4795841871191, 1168.696139003865, 12992.805107923388, 13100.803487947689, 13113.278769667664, 13120.212787232796, 13131.409086591126, 4586.0, 4642.187617166982, 4790.880227994258, 4802.27965805125, 4848.490908454632, 10171.54228059739, 10180.083792458714, 10182.541785619665, 10187.9490602548, 10196.38821670702, 5460.590455715837, 5480.369757477862, 5499.285092937893, 5526.723663816793, 5529.30883639545, 4577.908441831211, 4722.055588882237, 4909.165441874889, 5060.165072762953, 5191.377034755854, 3771.358868992278, 3878.9224215515533, 3936.252112098692, 3955.6835453163676, 3958.802059897051, 1162.2619636530865, 1162.4710756605723, 1162.5233654201736, 1169.2107827216594, 1170.3446070200714, 800.7677773445636, 918.6049998500575, 992.9453880036667, 998.9400635961865, 1010.2322235101376, 6109.419605137505, 6131.50947924165, 6148.1699970503405, 6184.319724830265, 6232.407921247474, 979.5787811241235, 990.4453506036642, 991.3159919655415, 1001.2890847498358, 1026.461107918334, 4208.494980602286, 4284.4430224070675, 4324.0919406924895, 4419.425474688334, 4440.822367105279, 11269.66191014271, 11776.293422394683, 11778.646640600795, 11791.88208117925, 11797.587084452003, 10703.83944240837, 11051.226414150933, 11257.831132533018, 11594.826077608843, 11687.474063667156, 8248.46384984974, 8334.333253339719, 8548.230659240699, 8553.315734741205, 8558.358123140664, 6354.555181137461, 6445.16212892321, 6459.257185423737, 6521.347865213441, 6577.934220657732, 10212.948935255574, 10585.100266477435, 10586.41774702368, 10591.311564748266, 10595.735106622396, 10645.859471456093, 10663.146948244277, 10785.40680262593, 10817.350958942488, 10889.401082940198, 7350.228226036403, 7490.925090749023, 7589.354904833151, 8073.071596766447, 8230.176982301722, 8747.737567872973, 9041.412308199946, 9043.095690430904, 9061.365704400892, 9074.773130671787, 7982.680692772224, 8079.919200807916, 8115.147909469657, 8259.132791056853, 8339.166083391612, 7841.137474877873, 7876.133625301327, 7885.5662938538935, 7999.760007199793, 8059.0, 6910.827229319308, 6949.409300209539, 7000.579965202104, 7025.192102908027, 7103.112110986127, 5231.869203269949, 5253.159494480865, 5308.946910531, 5312.0969435196885, 5441.020616289106, 5271.367435907716, 5318.175682769177, 5371.301730774974, 5412.161115027177, 5598.552115830642], "value": 4769.464536580505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4589878358615, 327.68434734540824, 328.59746810157554, 329.78563933443246, 335.59560729321163, 5268.578513718903, 5328.866778330544, 5343.358796944362, 5347.572194224457, 5351.4113447520795, 5001.574866136374, 5005.274235235888, 5144.871378215546, 5164.6384753067305, 5303.2575439438415, 4075.9388609170887, 4094.160697057096, 4094.651954583864, 4097.528784189826, 4107.917841643165, 4105.158442519277, 4115.156392939455, 4155.065110350177, 4155.439015732883, 4169.457970463835, 3875.2830726315583, 3946.7039972002217, 4095.5290141633645, 4112.342025275956, 4114.80670605524, 4081.244969680589, 4083.8570650027104, 4086.5504794472586, 4101.692373072032, 4119.217348703737, 3641.9453708194396, 3646.6535679110443, 3647.471116688065, 3648.993053820388, 3653.1597732521404, 5022.723750193738, 5055.494450554915, 5106.9489305106845, 5182.766775495112, 5184.896302073975, 4679.906401871977, 4681.882952926204, 4697.084068606623, 4702.576768090888, 4746.240601503743, 5394.32570928634, 5452.318460192476, 5471.23402723619, 5472.616916815825, 5480.725963701799, 3684.4657524658774, 3883.0, 3955.2880481513316, 3980.1840622672285, 3982.422548730418, 5622.859428514279, 5626.127950167731, 5639.15412688096, 5668.57485688575, 5686.668465928949, 4009.5789942055662, 4026.53694825093, 4043.7978101094827, 4051.1897620476025, 4053.574374690674, 3847.5190601174854, 4069.5726948670554, 4085.571015043437, 4097.91804163921, 4103.507579090468, 4605.6776025678555, 4658.417697787777, 4665.930011049837, 4666.976665116653, 4672.509386514435, 5509.3664228614225, 5524.171374293807, 5533.944660553343, 5535.69911070898, 5548.4451554845, 1335.946562137523, 1396.8812650924583, 1412.2797373339465, 1413.7596608576566, 1417.1922004457567, 884.2660591708866, 909.5765127575323, 911.9042500537348, 915.4232833315102, 918.807050519385, 4732.692374995614, 4767.046590681877, 4768.6661933665, 4776.376032149016, 4819.349387832668, 4505.43682039745, 4975.353204083446, 4978.6017118630425, 4987.478818960252, 5001.224810154432, 4704.411948506437, 4712.670113092119, 4717.504662010508, 4734.976325118352, 4756.7145971241835, 2627.618995245717, 2647.788176945878, 2648.4305874236748, 2648.814582979173, 2649.986750066237, 4990.251462280687, 5132.923006154911, 5142.8971420572125, 5180.176803642024, 5182.611304152204, 4937.432535081737, 4987.177115775857, 5016.08102439118, 5041.243813427942, 5063.822766203165, 5064.341220859004, 5135.4094279157625, 5153.561947234527, 5159.374796938952, 5177.550285919949, 4672.299155126758, 4885.778555361159, 4895.657303988829, 4901.823562345083, 4961.7271050092595, 4868.586170175575, 4888.633352498506, 4909.533594308535, 4924.384451943507, 4970.850874473772, 5124.590032797293, 5171.405288391733, 5172.353455818023, 5175.809563800422, 5192.870178245574, 3579.6420357963993, 3673.669369756628, 3691.5201023866725, 3697.205100903319, 3710.591834898105, 4909.159065350494, 5328.200769884394, 5493.7802487900035, 5556.360728654019, 5676.2337084493065, 5442.972785136049, 5468.152436372368, 5489.807856724996, 5495.3347626401965, 5497.835064948058, 5287.550558202596, 5518.668879867221, 5530.668159910419, 5536.612437129363, 5545.833624991256, 5434.23387399089, 5452.672839629635, 5453.372862120748, 5457.972710136424, 5462.268865567216, 5523.834284971457, 5544.611877168721, 5567.47109024642, 5595.188697638901, 5623.634463759842, 5074.644774865724, 5319.255304257485, 5362.892742145057, 5472.616916815785, 5475.4250803665045], "value": 4034.4385769546716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5892464521288, 738.6196109003864, 740.5556666000397, 761.2752104176592, 772.8995230620019, 15426.69146617067, 16015.919920400382, 16016.439424620141, 16020.35918563256, 16078.115703636295, 14057.437702491889, 14057.92971035146, 14090.929545352285, 14094.295285235748, 14143.787843182361, 782.4522834016198, 802.2699343597328, 804.3806269172734, 804.5936801915025, 804.6298702596783, 790.1387487638473, 795.2047952047952, 795.6817273090752, 796.9481983671043, 797.7447216890597, 842.065307508668, 843.3632607381419, 844.3498506150261, 844.7254642241265, 844.9915500844975, 835.8662613981794, 836.8786525953702, 838.0739283092187, 838.4927119092982, 838.5388036579888, 619.4827319188483, 620.512897375558, 621.0125899819263, 621.0652967284209, 621.2886245249209, 13492.12301200419, 13576.0, 13594.0, 13636.318184090855, 13640.522581709693, 12432.564860229848, 12648.367581620882, 12838.743225135446, 12919.483220671162, 13247.07270491066, 11214.607488737936, 11509.884901150965, 11941.701457463547, 11950.760984780343, 11967.461464234131, 4331.913361732779, 4356.542563030899, 4445.044315472189, 4455.5098939117, 4472.351509031205, 71683.28316716818, 72132.0, 72951.0, 73218.0, 73729.63135184343, 10834.566617335377, 10918.611609814578, 11002.449877506093, 11027.44862756859, 11094.0, 19624.215031398584, 19715.211391544464, 19724.605507889763, 19754.802451975585, 19809.801901980794, 7912.762617121495, 8160.061592916772, 8220.465669731448, 8282.17178282167, 8446.282066024334, 4507.2112380333965, 4678.953210467852, 4697.412823397075, 4794.616430685537, 4825.276208568743, 3430.588329400488, 3545.308664810389, 3547.787132772042, 3551.2009797795804, 3554.235839294564, 567.324883388766, 569.8888716700204, 575.0540361105957, 576.4940475015278, 584.2463222443001, 636.5162476517787, 669.9296573859674, 677.4208052115371, 690.9309069093151, 697.4664381747967, 9500.714978550655, 9746.512674366253, 9891.752706182404, 9924.80150396988, 9979.0, 670.8088194864538, 680.5542369747823, 688.449240607512, 690.7444245629149, 694.5818656745902, 4542.159700455426, 4829.782659780319, 4874.390701162355, 4929.137400954819, 4933.728644924564, 76120.61939690266, 118664.0, 119261.0, 123730.38134809268, 127229.36385318014, 61539.692301538205, 93071.53464232771, 99784.50107749415, 103227.4838625817, 103683.48158259311, 54371.45628543743, 57685.711571441876, 61266.0, 72383.6380818103, 86654.56672716596, 9575.521223938915, 10001.599936002478, 10187.796244074929, 10236.846447303147, 10237.74405639865, 49941.0, 50062.0, 50460.67398879144, 50683.493165069354, 51500.742496288774, 69319.30680693129, 71713.0, 75518.62240688762, 76177.0, 76238.61880690783, 12672.873271267537, 12737.55418560346, 12869.420876060412, 13051.934740326238, 13395.196288222738, 13562.525311614047, 13671.384787684778, 13797.862021380059, 14001.0, 14240.145591264558, 13097.345132743134, 13515.459381624625, 13838.0, 14152.78770818418, 14318.642033949234, 13639.522616708367, 14042.15747055139, 14091.506797262047, 14177.291135443393, 14732.337044832793, 13182.538611148564, 13329.466821327425, 13590.79613805774, 13798.0, 14052.367643456273, 10948.726281843017, 11208.55165793359, 11301.886981130083, 11588.478518466858, 11707.941460292644, 11515.193936424705, 11542.711432214262, 11934.0, 12160.75678486443, 12200.694982625506], "value": 7391.33106135618, "unit": "score"}], "name": "dromaeo_css", "value": 7190.18603447902, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 113.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 120.0, 157.0, 122.0, 117.0, 119.0, 116.0, 152.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 119.0, 76.0, 76.0, 77.0, 77.0, 105.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 84.0, 82.0, 82.0, 102.0, 82.0, 82.0, 116.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 50.0, 50.0, 52.0, 50.0, 50.0, 51.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 81.0, 84.0, 78.0, 83.0, 79.0, 79.0, 78.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 128.0, 122.0, 135.0, 130.0, 137.0, 124.0, 164.0, 128.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 164.0, 163.0, 164.0, 166.0, 164.0, 164.0, 164.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 63.0, 63.0, 65.0, 67.0, 65.0, 64.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1485.4000000000003, "alertThreshold": 2.0}]} 12:41:38 INFO - Return code: 0 12:41:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:41:38 INFO - # TBPL SUCCESS # 12:41:38 INFO - Running post-action listener: _resource_record_post_action 12:41:38 INFO - [mozharness: 2016-09-28 19:41:38.382760Z] Finished run-tests step (success) 12:41:38 INFO - Running post-run listener: _resource_record_post_run 12:41:38 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 409694208; Read time: 0; Write time: 415972 12:41:38 INFO - TinderboxPrint: CPU usage
13.1% 12:41:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:41:38 INFO - TinderboxPrint: I/O write bytes / time
409,694,208 / 415,972 12:41:38 INFO - TinderboxPrint: CPU idle
8,288.4 (86.9%) 12:41:38 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 12:41:38 INFO - TinderboxPrint: Swap in / out
0 / 0 12:41:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121171968; Read time: 0; Write time: 125568 12:41:38 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288522240; Read time: 0; Write time: 290404 12:41:39 INFO - Running post-run listener: _upload_blobber_files 12:41:39 INFO - Blob upload gear active. 12:41:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:39 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:41:39 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:41:39 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:41:39 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:45 INFO - (blobuploader) - INFO - Done attempting. 12:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:46 INFO - (blobuploader) - INFO - Done attempting. 12:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:47 INFO - (blobuploader) - INFO - Done attempting. 12:41:47 INFO - (blobuploader) - INFO - Iteration through files over. 12:41:47 INFO - Return code: 0 12:41:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:41:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:41:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f283abdf93aabaec0b083fd3c99aad58632ee19745057554f70df631c94b2e137d2a33480fc7e03d658bdcedf7c23366f75402cb8f82f69c1aa66e88593ad85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6c06456f72587c72c03fbbcf0372d2b7751f6a42578cee8dbedeab53340be5e559a7a3bac313385f763adbd6cb2fd8ca694b0258d8e98e336c3bd3bde9cb345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6f996554e9a83bbf81a0bbcd4a2f9bc5d377a823f78ffc8d004ab3aad43fb29f3a32b83300dc67b0d5c7cd5cf931ba3e53cf7693353338235e3cb9f767eba06"} 12:41:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:41:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:41:47 INFO - Contents: 12:41:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f283abdf93aabaec0b083fd3c99aad58632ee19745057554f70df631c94b2e137d2a33480fc7e03d658bdcedf7c23366f75402cb8f82f69c1aa66e88593ad85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6c06456f72587c72c03fbbcf0372d2b7751f6a42578cee8dbedeab53340be5e559a7a3bac313385f763adbd6cb2fd8ca694b0258d8e98e336c3bd3bde9cb345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6f996554e9a83bbf81a0bbcd4a2f9bc5d377a823f78ffc8d004ab3aad43fb29f3a32b83300dc67b0d5c7cd5cf931ba3e53cf7693353338235e3cb9f767eba06"} 12:41:47 INFO - Running post-run listener: copy_logs_to_upload_dir 12:41:47 INFO - Copying logs to upload dir... 12:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs 12:41:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.943794 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 12:41:46.381703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 12:41:46.385065) ========= 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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 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/7f283abdf93aabaec0b083fd3c99aad58632ee19745057554f70df631c94b2e137d2a33480fc7e03d658bdcedf7c23366f75402cb8f82f69c1aa66e88593ad85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6c06456f72587c72c03fbbcf0372d2b7751f6a42578cee8dbedeab53340be5e559a7a3bac313385f763adbd6cb2fd8ca694b0258d8e98e336c3bd3bde9cb345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6f996554e9a83bbf81a0bbcd4a2f9bc5d377a823f78ffc8d004ab3aad43fb29f3a32b83300dc67b0d5c7cd5cf931ba3e53cf7693353338235e3cb9f767eba06"} 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.011504 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/7f283abdf93aabaec0b083fd3c99aad58632ee19745057554f70df631c94b2e137d2a33480fc7e03d658bdcedf7c23366f75402cb8f82f69c1aa66e88593ad85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6c06456f72587c72c03fbbcf0372d2b7751f6a42578cee8dbedeab53340be5e559a7a3bac313385f763adbd6cb2fd8ca694b0258d8e98e336c3bd3bde9cb345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6f996554e9a83bbf81a0bbcd4a2f9bc5d377a823f78ffc8d004ab3aad43fb29f3a32b83300dc67b0d5c7cd5cf931ba3e53cf7693353338235e3cb9f767eba06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 12:41:46.410453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:41:46.410797) ========= 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=fa44defc139c4ba8574fe040000001db-1475082373.957791-553658695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 12:41:46.495202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 12:41:46.495924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 12:41:46.496696) ========= ========= Total master_lag: 0.18 =========