builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1475078681.96 results: success (0) buildid: 20160928075920 builduid: 104803d36f594df3bdb151587e560a59 revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:41.962993) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:41.963517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:41.963857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:41.989068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:41.989446) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 09:04:42-- 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% 33.2M=0s 2016-09-28 09:04:42 (33.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075117 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:42.152970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 09:04:42.153326) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022474 ========= master_lag: 2.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 09:04:44.366262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:04:44.370717) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 09:04:44,795 truncating revision to first 12 chars 2016-09-28 09:04:44,796 Setting DEBUG logging. 2016-09-28 09:04:44,796 attempt 1/10 2016-09-28 09:04:44,796 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 09:04:45,212 unpacking tar archive at: fx-team-eda310265741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.753702 ========= master_lag: 0.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:04:45.659478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:45.659761) ========= script_repo_revision: eda310265741fb26bbd91a92017bc6337fcc8de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:45.660111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:45.660370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:04:45.739514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-28 09:04:45.739796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:46 INFO - MultiFileLogger online at 20160928 09:04:46 in /builds/slave/test 09:04:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:04:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:46 INFO - {'append_to_log': False, 09:04:46 INFO - 'base_work_dir': '/builds/slave/test', 09:04:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:46 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:46 INFO - 'config_files': ('talos/linux_config.py',), 09:04:46 INFO - 'default_actions': ('clobber', 09:04:46 INFO - 'read-buildbot-config', 09:04:46 INFO - 'download-and-extract', 09:04:46 INFO - 'populate-webroot', 09:04:46 INFO - 'create-virtualenv', 09:04:46 INFO - 'install', 09:04:46 INFO - 'run-tests'), 09:04:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:46 INFO - 'download_minidump_stackwalk': True, 09:04:46 INFO - 'download_symbols': 'ondemand', 09:04:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:46 INFO - 'installer_path': 'installer.exe', 09:04:46 INFO - 'log_level': 'info', 09:04:46 INFO - 'log_name': 'talos', 09:04:46 INFO - 'log_to_console': True, 09:04:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:46 INFO - 'opt_config_files': (), 09:04:46 INFO - 'pip_index': False, 09:04:46 INFO - 'sps_profile': False, 09:04:46 INFO - 'sps_profile_interval': 0, 09:04:46 INFO - 'suite': 'dromaeojs', 09:04:46 INFO - 'system_bits': '32', 09:04:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:46 INFO - 'title': 'talos-linux64-ix-047', 09:04:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:46 INFO - 'use_talos_json': True, 09:04:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:46 INFO - 'work_dir': 'build'} 09:04:46 INFO - [mozharness: 2016-09-28 16:04:46.254899Z] Running clobber step. 09:04:46 INFO - Running pre-action listener: _resource_record_pre_action 09:04:46 INFO - Running main action method: clobber 09:04:46 INFO - rmtree: /builds/slave/test/build 09:04:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:47 INFO - Running post-action listener: _resource_record_post_action 09:04:47 INFO - [mozharness: 2016-09-28 16:04:47.226310Z] Finished clobber step (success) 09:04:47 INFO - [mozharness: 2016-09-28 16:04:47.226412Z] Running read-buildbot-config step. 09:04:47 INFO - Running pre-action listener: _resource_record_pre_action 09:04:47 INFO - Running main action method: read_buildbot_config 09:04:47 INFO - Using buildbot properties: 09:04:47 INFO - { 09:04:47 INFO - "project": "", 09:04:47 INFO - "product": "firefox", 09:04:47 INFO - "script_repo_revision": "production", 09:04:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:04:47 INFO - "repository": "", 09:04:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:04:47 INFO - "buildid": "20160928075920", 09:04:47 INFO - "pgo_build": "False", 09:04:47 INFO - "basedir": "/builds/slave/test", 09:04:47 INFO - "buildnumber": 3354, 09:04:47 INFO - "slavename": "talos-linux64-ix-047", 09:04:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:04:47 INFO - "platform": "ubuntu64_hw", 09:04:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:47 INFO - "branch": "fx-team", 09:04:47 INFO - "repo_path": "integration/fx-team", 09:04:47 INFO - "revision": "eda310265741fb26bbd91a92017bc6337fcc8de6", 09:04:47 INFO - "stage_platform": "linux64", 09:04:47 INFO - "builduid": "104803d36f594df3bdb151587e560a59", 09:04:47 INFO - "slavebuilddir": "test" 09:04:47 INFO - } 09:04:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:04:47 INFO - Running post-action listener: _resource_record_post_action 09:04:47 INFO - [mozharness: 2016-09-28 16:04:47.228838Z] Finished read-buildbot-config step (success) 09:04:47 INFO - [mozharness: 2016-09-28 16:04:47.228925Z] Running download-and-extract step. 09:04:47 INFO - Running pre-action listener: _resource_record_pre_action 09:04:47 INFO - Running main action method: download_and_extract 09:04:47 INFO - mkdir: /builds/slave/test/build/tests 09:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:47 INFO - trying https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:04:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/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 09:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/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 09:04:47 INFO - Downloaded 1361 bytes. 09:04:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:04:47 INFO - Using the following test package requirements: 09:04:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'jsshell-linux-x86_64.zip'], 09:04:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:04:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:04:48 INFO - Expected file size: 20415656 09:04:48 INFO - Content-Encoding None 09:04:48 INFO - Content-Type application/zip 09:04:48 INFO - Http code 200 09:04:52 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 09:04:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:04:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:04:53 INFO - Expected file size: 20415656 09:04:53 INFO - Content-Encoding None 09:04:53 INFO - Content-Type application/zip 09:04:53 INFO - Http code 200 09:04:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:04:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:04:58 INFO - Expected file size: 14414067 09:04:58 INFO - Content-Encoding None 09:04:58 INFO - Content-Type application/zip 09:04:58 INFO - Http code 200 09:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:59 INFO - trying https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/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 09:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/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 09:05:01 INFO - Downloaded 55740018 bytes. 09:05:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:05:01 INFO - mkdir: /builds/slave/test/properties 09:05:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:01 INFO - Contents: 09:05:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:05:02 INFO - Running post-action listener: _resource_record_post_action 09:05:02 INFO - Running post-action listener: set_extra_try_arguments 09:05:02 INFO - [mozharness: 2016-09-28 16:05:02.039074Z] Finished download-and-extract step (success) 09:05:02 INFO - [mozharness: 2016-09-28 16:05:02.039300Z] Running populate-webroot step. 09:05:02 INFO - Running pre-action listener: _resource_record_pre_action 09:05:02 INFO - Running main action method: populate_webroot 09:05:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:02 INFO - '--tppagecycles', 09:05:02 INFO - '7'], 09:05:02 INFO - 'tests': ['tsvgm']}}, 09:05:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['damp', 'tps']}, 09:05:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'tests': ['damp', 'tps']}, 09:05:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['dromaeo_dom']}, 09:05:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['basic_compositor_video']}, 09:05:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tsvgx', 09:05:02 INFO - 'tsvgr_opacity', 09:05:02 INFO - 'tart', 09:05:02 INFO - 'tscrollx', 09:05:02 INFO - 'cart']}, 09:05:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:02 INFO - 'tsvgr_opacity', 09:05:02 INFO - 'tart', 09:05:02 INFO - 'tscrollx', 09:05:02 INFO - 'cart']}, 09:05:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tp5o']}, 09:05:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'tests': ['tp5o']}, 09:05:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s', 09:05:02 INFO - '--xperf_path', 09:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:02 INFO - 'tests': ['tp5n']}, 09:05:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:02 INFO - 'talos_options': ['--xperf_path', 09:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:02 INFO - 'tests': ['tp5n']}}, 09:05:02 INFO - 'talos.zip': {'path': '', 09:05:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:02 INFO - Running post-action listener: _resource_record_post_action 09:05:02 INFO - [mozharness: 2016-09-28 16:05:02.061459Z] Finished populate-webroot step (success) 09:05:02 INFO - [mozharness: 2016-09-28 16:05:02.061547Z] Running create-virtualenv step. 09:05:02 INFO - Running pre-action listener: _resource_record_pre_action 09:05:02 INFO - Running main action method: create_virtualenv 09:05:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:02 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 09:05:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:02 INFO - Using real prefix '/usr' 09:05:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:04 INFO - Installing pip.................done. 09:05:04 INFO - Return code: 0 09:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:04 INFO - Reading from file tmpfile_stdout 09:05:04 INFO - Output received: 09:05:04 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) 09:05:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:04 INFO - Using env: {'DISPLAY': ':0', 09:05:04 INFO - 'HOME': '/home/cltbld', 09:05:04 INFO - 'LANG': 'en_US.UTF-8', 09:05:04 INFO - 'LANGUAGE': 'en_US:en', 09:05:04 INFO - 'LOGNAME': 'cltbld', 09:05:04 INFO - 'MAIL': '/var/mail/cltbld', 09:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:04 INFO - 'MOZ_NO_REMOTE': '1', 09:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:04 INFO - 'NO_EM_RESTART': '1', 09:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:04 INFO - 'PWD': '/builds/slave/test', 09:05:04 INFO - 'SHELL': '/bin/bash', 09:05:04 INFO - 'SHLVL': '1', 09:05:04 INFO - 'TERM': 'linux', 09:05:04 INFO - 'TMOUT': '86400', 09:05:04 INFO - 'USER': 'cltbld', 09:05:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:04 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 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 09:05:05 INFO - Cleaning up... 09:05:05 INFO - Return code: 0 09:05:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:05 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 09:05:05 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 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 INFO - Downloading/unpacking psutil>=3.1.1 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:07 INFO - Installing collected packages: psutil 09:05:07 INFO - Running setup.py install for psutil 09:05:07 INFO - building 'psutil._psutil_linux' extension 09:05:07 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 09:05:07 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 09:05:07 INFO - building 'psutil._psutil_posix' extension 09:05:07 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 09:05:07 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 09:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:07 INFO - Successfully installed psutil 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:07 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')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:07 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 09:05:07 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 09:05:07 INFO - Using env: {'DISPLAY': ':0', 09:05:07 INFO - 'HOME': '/home/cltbld', 09:05:07 INFO - 'LANG': 'en_US.UTF-8', 09:05:07 INFO - 'LANGUAGE': 'en_US:en', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MAIL': '/var/mail/cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SHLVL': '1', 09:05:07 INFO - 'TERM': 'linux', 09:05:07 INFO - 'TMOUT': '86400', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - '_': '/tools/buildbot/bin/python'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:09 INFO - Installing collected packages: mozsystemmonitor 09:05:09 INFO - Running setup.py install for mozsystemmonitor 09:05:10 INFO - Successfully installed mozsystemmonitor 09:05:10 INFO - Cleaning up... 09:05:10 INFO - Return code: 0 09:05:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:10 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')]} 09:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:10 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')]} 09:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:10 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:10 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 09:05:10 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 09:05:10 INFO - Using env: {'DISPLAY': ':0', 09:05:10 INFO - 'HOME': '/home/cltbld', 09:05:10 INFO - 'LANG': 'en_US.UTF-8', 09:05:10 INFO - 'LANGUAGE': 'en_US:en', 09:05:10 INFO - 'LOGNAME': 'cltbld', 09:05:10 INFO - 'MAIL': '/var/mail/cltbld', 09:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:10 INFO - 'MOZ_NO_REMOTE': '1', 09:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:10 INFO - 'NO_EM_RESTART': '1', 09:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:10 INFO - 'PWD': '/builds/slave/test', 09:05:10 INFO - 'SHELL': '/bin/bash', 09:05:10 INFO - 'SHLVL': '1', 09:05:10 INFO - 'TERM': 'linux', 09:05:10 INFO - 'TMOUT': '86400', 09:05:10 INFO - 'USER': 'cltbld', 09:05:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:10 INFO - '_': '/tools/buildbot/bin/python'} 09:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:12 INFO - warning: no files found matching '*.txt' 09:05:12 INFO - no previously-included directories found matching 'build' 09:05:12 INFO - no previously-included directories found matching 'dist' 09:05:12 INFO - no previously-included directories found matching '.git*' 09:05:12 INFO - Installing collected packages: jsonschema, functools32 09:05:12 INFO - Running setup.py install for functools32 09:05:12 INFO - warning: no files found matching '*.txt' 09:05:12 INFO - no previously-included directories found matching 'build' 09:05:12 INFO - no previously-included directories found matching 'dist' 09:05:12 INFO - no previously-included directories found matching '.git*' 09:05:12 INFO - Successfully installed jsonschema functools32 09:05:12 INFO - Cleaning up... 09:05:12 INFO - Return code: 0 09:05:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05:12 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')]} 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 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')]} 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:12 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 09:05:12 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 09:05:12 INFO - Using env: {'DISPLAY': ':0', 09:05:12 INFO - 'HOME': '/home/cltbld', 09:05:12 INFO - 'LANG': 'en_US.UTF-8', 09:05:12 INFO - 'LANGUAGE': 'en_US:en', 09:05:12 INFO - 'LOGNAME': 'cltbld', 09:05:12 INFO - 'MAIL': '/var/mail/cltbld', 09:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:12 INFO - 'MOZ_NO_REMOTE': '1', 09:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:12 INFO - 'NO_EM_RESTART': '1', 09:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:12 INFO - 'PWD': '/builds/slave/test', 09:05:12 INFO - 'SHELL': '/bin/bash', 09:05:12 INFO - 'SHLVL': '1', 09:05:12 INFO - 'TERM': 'linux', 09:05:12 INFO - 'TMOUT': '86400', 09:05:12 INFO - 'USER': 'cltbld', 09:05:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:12 INFO - '_': '/tools/buildbot/bin/python'} 09:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:12 INFO - Cleaning up... 09:05:12 INFO - Return code: 0 09:05:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:12 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')]} 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 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')]} 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:12 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 09:05:12 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 09:05:12 INFO - Using env: {'DISPLAY': ':0', 09:05:12 INFO - 'HOME': '/home/cltbld', 09:05:12 INFO - 'LANG': 'en_US.UTF-8', 09:05:12 INFO - 'LANGUAGE': 'en_US:en', 09:05:12 INFO - 'LOGNAME': 'cltbld', 09:05:12 INFO - 'MAIL': '/var/mail/cltbld', 09:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:12 INFO - 'MOZ_NO_REMOTE': '1', 09:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:12 INFO - 'NO_EM_RESTART': '1', 09:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:12 INFO - 'PWD': '/builds/slave/test', 09:05:12 INFO - 'SHELL': '/bin/bash', 09:05:12 INFO - 'SHLVL': '1', 09:05:12 INFO - 'TERM': 'linux', 09:05:12 INFO - 'TMOUT': '86400', 09:05:12 INFO - 'USER': 'cltbld', 09:05:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:12 INFO - '_': '/tools/buildbot/bin/python'} 09:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 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 09:05:15 INFO - Downloading docopt-0.6.1.tar.gz 09:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:15 INFO - Running setup.py install for blobuploader 09:05:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:15 INFO - Running setup.py install for requests 09:05:16 INFO - Running setup.py install for docopt 09:05:16 INFO - Successfully installed blobuploader requests docopt 09:05:16 INFO - Cleaning up... 09:05:16 INFO - Return code: 0 09:05:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:16 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')]} 09:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:16 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')]} 09:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:16 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:16 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 09:05:16 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 09:05:16 INFO - Using env: {'DISPLAY': ':0', 09:05:16 INFO - 'HOME': '/home/cltbld', 09:05:16 INFO - 'LANG': 'en_US.UTF-8', 09:05:16 INFO - 'LANGUAGE': 'en_US:en', 09:05:16 INFO - 'LOGNAME': 'cltbld', 09:05:16 INFO - 'MAIL': '/var/mail/cltbld', 09:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:16 INFO - 'MOZ_NO_REMOTE': '1', 09:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:16 INFO - 'NO_EM_RESTART': '1', 09:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:16 INFO - 'PWD': '/builds/slave/test', 09:05:16 INFO - 'SHELL': '/bin/bash', 09:05:16 INFO - 'SHLVL': '1', 09:05:16 INFO - 'TERM': 'linux', 09:05:16 INFO - 'TMOUT': '86400', 09:05:16 INFO - 'USER': 'cltbld', 09:05:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:16 INFO - '_': '/tools/buildbot/bin/python'} 09:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:16 INFO - Running setup.py (path:/tmp/pip-q0I6FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:16 INFO - Running setup.py (path:/tmp/pip-xepPRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:16 INFO - Running setup.py (path:/tmp/pip-lhNW17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:16 INFO - Running setup.py (path:/tmp/pip-xdFRGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:16 INFO - Running setup.py (path:/tmp/pip-ojrK0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:16 INFO - Running setup.py (path:/tmp/pip-JqlY3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:16 INFO - Running setup.py (path:/tmp/pip-SlkP6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:17 INFO - Running setup.py (path:/tmp/pip-20_yGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:17 INFO - Running setup.py (path:/tmp/pip-MdTIl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:17 INFO - Running setup.py (path:/tmp/pip-sk5vHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:17 INFO - Running setup.py (path:/tmp/pip-RnWfpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:17 INFO - Running setup.py (path:/tmp/pip-kBewxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:17 INFO - Running setup.py (path:/tmp/pip-ncIyrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:17 INFO - Running setup.py (path:/tmp/pip-x4sZW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:17 INFO - Running setup.py (path:/tmp/pip-N2jE4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:17 INFO - Running setup.py (path:/tmp/pip-peEz6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:17 INFO - Running setup.py (path:/tmp/pip-uom8kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:17 INFO - Running setup.py install for manifestparser 09:05:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:17 INFO - Running setup.py install for mozcrash 09:05:17 INFO - Running setup.py install for mozdebug 09:05:18 INFO - Running setup.py install for mozdevice 09:05:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for mozfile 09:05:18 INFO - Running setup.py install for mozhttpd 09:05:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for mozinfo 09:05:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for mozInstall 09:05:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for mozleak 09:05:18 INFO - Running setup.py install for mozlog 09:05:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for moznetwork 09:05:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:18 INFO - Running setup.py install for mozprocess 09:05:19 INFO - Running setup.py install for mozprofile 09:05:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:19 INFO - Running setup.py install for mozrunner 09:05:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:19 INFO - Running setup.py install for mozscreenshot 09:05:19 INFO - Running setup.py install for moztest 09:05:19 INFO - Running setup.py install for mozversion 09:05:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:19 INFO - Cleaning up... 09:05:19 INFO - Return code: 0 09:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:19 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')]} 09:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 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')]} 09:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:19 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 09:05:19 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 09:05:19 INFO - Using env: {'DISPLAY': ':0', 09:05:19 INFO - 'HOME': '/home/cltbld', 09:05:19 INFO - 'LANG': 'en_US.UTF-8', 09:05:19 INFO - 'LANGUAGE': 'en_US:en', 09:05:19 INFO - 'LOGNAME': 'cltbld', 09:05:19 INFO - 'MAIL': '/var/mail/cltbld', 09:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:19 INFO - 'MOZ_NO_REMOTE': '1', 09:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:19 INFO - 'NO_EM_RESTART': '1', 09:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:19 INFO - 'PWD': '/builds/slave/test', 09:05:19 INFO - 'SHELL': '/bin/bash', 09:05:19 INFO - 'SHLVL': '1', 09:05:19 INFO - 'TERM': 'linux', 09:05:19 INFO - 'TMOUT': '86400', 09:05:19 INFO - 'USER': 'cltbld', 09:05:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:19 INFO - '_': '/tools/buildbot/bin/python'} 09:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:19 INFO - Running setup.py (path:/tmp/pip-VVTsB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:19 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)) 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:19 INFO - Running setup.py (path:/tmp/pip-rVxAF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:19 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)) 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:19 INFO - Running setup.py (path:/tmp/pip-UwX922-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:20 INFO - Running setup.py (path:/tmp/pip-Br2lGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:20 INFO - Running setup.py (path:/tmp/pip-6TYzSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:20 INFO - Running setup.py (path:/tmp/pip-8WDdif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:20 INFO - Running setup.py (path:/tmp/pip-pZwaoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:20 INFO - Running setup.py (path:/tmp/pip-_knd53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:20 INFO - Running setup.py (path:/tmp/pip-5eExm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:20 INFO - Running setup.py (path:/tmp/pip-yPPlKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:20 INFO - Running setup.py (path:/tmp/pip-GeGBRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:20 INFO - Running setup.py (path:/tmp/pip-TD3k_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:20 INFO - Running setup.py (path:/tmp/pip-zJg5bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:20 INFO - Running setup.py (path:/tmp/pip-tU8Ey_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:20 INFO - Running setup.py (path:/tmp/pip-3mCvz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:20 INFO - Running setup.py (path:/tmp/pip-x1jaoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:20 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)) 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:20 INFO - Running setup.py (path:/tmp/pip-TwBtn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:21 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)) 09:05:21 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)) 09:05:21 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)) 09:05:21 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)) 09:05:21 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)) 09:05:21 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)) 09:05:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:22 INFO - Downloading blessings-1.6.tar.gz 09:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:23 INFO - Installing collected packages: blessings 09:05:23 INFO - Running setup.py install for blessings 09:05:23 INFO - Successfully installed blessings 09:05:23 INFO - Cleaning up... 09:05:23 INFO - Return code: 0 09:05:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:23 INFO - Reading from file tmpfile_stdout 09:05:23 INFO - Current package versions: 09:05:23 INFO - argparse == 1.2.1 09:05:23 INFO - blessings == 1.6 09:05:23 INFO - blobuploader == 1.2.4 09:05:23 INFO - docopt == 0.6.1 09:05:23 INFO - functools32 == 3.2.3-2 09:05:23 INFO - jsonschema == 2.5.1 09:05:23 INFO - manifestparser == 1.1 09:05:23 INFO - mozInstall == 1.12 09:05:23 INFO - mozcrash == 0.17 09:05:23 INFO - mozdebug == 0.1 09:05:23 INFO - mozdevice == 0.48 09:05:23 INFO - mozfile == 1.2 09:05:23 INFO - mozhttpd == 0.7 09:05:23 INFO - mozinfo == 0.9 09:05:23 INFO - mozleak == 0.1 09:05:23 INFO - mozlog == 3.4 09:05:23 INFO - moznetwork == 0.27 09:05:23 INFO - mozprocess == 0.23 09:05:23 INFO - mozprofile == 0.28 09:05:23 INFO - mozrunner == 6.12 09:05:23 INFO - mozscreenshot == 0.1 09:05:23 INFO - mozsystemmonitor == 0.3 09:05:23 INFO - moztest == 0.7 09:05:23 INFO - mozversion == 1.4 09:05:23 INFO - psutil == 3.1.1 09:05:23 INFO - requests == 1.2.3 09:05:23 INFO - wsgiref == 0.1.2 09:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:23 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 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:23 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 09:05:23 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 09:05:23 INFO - Using env: {'DISPLAY': ':0', 09:05:23 INFO - 'HOME': '/home/cltbld', 09:05:23 INFO - 'LANG': 'en_US.UTF-8', 09:05:23 INFO - 'LANGUAGE': 'en_US:en', 09:05:23 INFO - 'LOGNAME': 'cltbld', 09:05:23 INFO - 'MAIL': '/var/mail/cltbld', 09:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:23 INFO - 'MOZ_NO_REMOTE': '1', 09:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:23 INFO - 'NO_EM_RESTART': '1', 09:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:23 INFO - 'PWD': '/builds/slave/test', 09:05:23 INFO - 'SHELL': '/bin/bash', 09:05:23 INFO - 'SHLVL': '1', 09:05:23 INFO - 'TERM': 'linux', 09:05:23 INFO - 'TMOUT': '86400', 09:05:23 INFO - 'USER': 'cltbld', 09:05:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:23 INFO - '_': '/tools/buildbot/bin/python'} 09:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 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)) 09:05:23 INFO - Cleaning up... 09:05:23 INFO - Return code: 0 09:05:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9872e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', '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 09:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:23 INFO - Using env: {'DISPLAY': ':0', 09:05:23 INFO - 'HOME': '/home/cltbld', 09:05:23 INFO - 'LANG': 'en_US.UTF-8', 09:05:23 INFO - 'LANGUAGE': 'en_US:en', 09:05:23 INFO - 'LOGNAME': 'cltbld', 09:05:23 INFO - 'MAIL': '/var/mail/cltbld', 09:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:23 INFO - 'MOZ_NO_REMOTE': '1', 09:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:23 INFO - 'NO_EM_RESTART': '1', 09:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:23 INFO - 'PWD': '/builds/slave/test', 09:05:23 INFO - 'SHELL': '/bin/bash', 09:05:23 INFO - 'SHLVL': '1', 09:05:23 INFO - 'TERM': 'linux', 09:05:23 INFO - 'TMOUT': '86400', 09:05:23 INFO - 'USER': 'cltbld', 09:05:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:23 INFO - '_': '/tools/buildbot/bin/python'} 09:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:23 INFO - Cleaning up... 09:05:23 INFO - Return code: 0 09:05:23 INFO - Running post-action listener: _resource_record_post_action 09:05:23 INFO - Running post-action listener: _start_resource_monitoring 09:05:23 INFO - Starting resource monitoring. 09:05:23 INFO - [mozharness: 2016-09-28 16:05:23.860773Z] Finished create-virtualenv step (success) 09:05:23 INFO - [mozharness: 2016-09-28 16:05:23.861359Z] Running install step. 09:05:23 INFO - Running pre-action listener: _resource_record_pre_action 09:05:23 INFO - Running main action method: install 09:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:24 INFO - Reading from file tmpfile_stdout 09:05:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:24 INFO - Reading from file tmpfile_stdout 09:05:24 INFO - Output received: 09:05:24 INFO - Usage: mozinstall [options] installer 09:05:24 INFO - Options: 09:05:24 INFO - -h, --help show this help message and exit 09:05:24 INFO - -d DEST, --destination=DEST 09:05:24 INFO - Directory to install application into. [default: 09:05:24 INFO - "/builds/slave/test"] 09:05:24 INFO - --app=APP Application being installed. [default: firefox] 09:05:24 INFO - mkdir: /builds/slave/test/build/application 09:05:24 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'] 09:05:24 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 09:05:40 INFO - Reading from file tmpfile_stdout 09:05:40 INFO - Output received: 09:05:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:40 INFO - Running post-action listener: _resource_record_post_action 09:05:40 INFO - [mozharness: 2016-09-28 16:05:40.327047Z] Finished install step (success) 09:05:40 INFO - [mozharness: 2016-09-28 16:05:40.327292Z] Running run-tests step. 09:05:40 INFO - Running pre-action listener: _resource_record_pre_action 09:05:40 INFO - Running main action method: run_tests 09:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:40 INFO - Python 2.7.3 09:05:40 INFO - Return code: 0 09:05:40 INFO - grabbing minidump binary from tooltool 09:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:40 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 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:40 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 09:05:40 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 09:05:40 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 09:05:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:40 INFO - Return code: 0 09:05:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 09:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 09:05:40 INFO - Using env: {'DISPLAY': ':0', 09:05:40 INFO - 'HOME': '/home/cltbld', 09:05:40 INFO - 'LANG': 'en_US.UTF-8', 09:05:40 INFO - 'LANGUAGE': 'en_US:en', 09:05:40 INFO - 'LOGNAME': 'cltbld', 09:05:40 INFO - 'MAIL': '/var/mail/cltbld', 09:05:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:40 INFO - 'MOZ_NO_REMOTE': '1', 09:05:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:40 INFO - 'NO_EM_RESTART': '1', 09:05:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:40 INFO - 'PWD': '/builds/slave/test', 09:05:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:40 INFO - 'SHELL': '/bin/bash', 09:05:40 INFO - 'SHLVL': '1', 09:05:40 INFO - 'TERM': 'linux', 09:05:40 INFO - 'TMOUT': '86400', 09:05:40 INFO - 'USER': 'cltbld', 09:05:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715', 09:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:40 INFO - '_': '/tools/buildbot/bin/python'} 09:05:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 09:05:40 INFO - mozversion application_buildid: 20160928075920 09:05:40 INFO - mozversion application_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 09:05:40 INFO - mozversion application_display_name: Nightly 09:05:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:40 INFO - mozversion application_name: Firefox 09:05:40 INFO - mozversion application_remotingname: firefox 09:05:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:05:40 INFO - mozversion application_vendor: Mozilla 09:05:40 INFO - mozversion application_version: 52.0a1 09:05:40 INFO - mozversion platform_buildid: 20160928075920 09:05:40 INFO - mozversion platform_changeset: eda310265741fb26bbd91a92017bc6337fcc8de6 09:05:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:40 INFO - mozversion platform_version: 52.0a1 09:05:40 INFO - using testdate: 1475078740 09:05:40 INFO - actual date: 1475078740 09:05:40 INFO - starting webserver on 'localhost:46026' 09:05:40 INFO - SUITE-START | Running 2 tests 09:05:40 INFO - TEST-START | dromaeo_css 09:05:40 INFO - operating with platform_type : linux_ 09:05:40 INFO - Initialising browser for dromaeo_css test... 09:05:40 INFO - TEST-INFO | started process 27934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdwGxj/profile http://localhost:46026/getInfo.html) 09:05:45 INFO - PROCESS | 27934 | __metrics Screen width/height:1600/1200 09:05:45 INFO - PROCESS | 27934 | colorDepth:24 09:05:45 INFO - PROCESS | 27934 | Browser inner width/height: 1024/697 09:05:45 INFO - PROCESS | 27934 | __metrics 09:05:45 INFO - PROCESS | 27934 | 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" 09:05:45 INFO - PROCESS | 27934 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:46 INFO - PROCESS | 27934 | console.error: PushService: 09:05:46 INFO - PROCESS | 27934 | stateChangeProcessEnqueue: Error transitioning state 09:05:46 INFO - PROCESS | 27934 | UnknownError 09:05:47 INFO - TEST-INFO | 27934: exit 0 09:05:47 INFO - Browser initialized. 09:05:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:47 INFO - TEST-INFO | started process 28015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdwGxj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:59 INFO - PROCESS | 28015 | RSS: Main: 174886912 09:05:59 INFO - PROCESS | 28015 | 09:06:51 INFO - PROCESS | 28015 | 1475078811070 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] 09:09:03 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46026/tests/dromaeo/cssquery-ext.html) 09:09:05 INFO - PROCESS | 28015 | RSS: Main: 266002432 09:09:05 INFO - PROCESS | 28015 | 09:12:07 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-ext.html (next: http://localhost:46026/tests/dromaeo/cssquery-jquery.html) 09:12:08 INFO - PROCESS | 28015 | RSS: Main: 272809984 09:12:08 INFO - PROCESS | 28015 | 09:15:10 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46026/tests/dromaeo/cssquery-mootools.html) 09:15:11 INFO - PROCESS | 28015 | RSS: Main: 219959296 09:15:11 INFO - PROCESS | 28015 | 09:18:13 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46026/tests/dromaeo/cssquery-prototype.html) 09:18:14 INFO - PROCESS | 28015 | RSS: Main: 220876800 09:18:14 INFO - PROCESS | 28015 | 09:21:17 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46026/tests/dromaeo/cssquery-yui.html) 09:21:17 INFO - PROCESS | 28015 | RSS: Main: 219475968 09:21:17 INFO - PROCESS | 28015 | 09:24:20 INFO - PROCESS | 28015 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-yui.html (next: http://localhost:46026/tests/dromaeo/cssquery-dojo.html) 09:24:21 INFO - PROCESS | 28015 | RSS: Main: 306655232 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | __start_tp_report 09:24:21 INFO - PROCESS | 28015 | _x_x_mozilla_page_load 09:24:21 INFO - PROCESS | 28015 | _x_x_mozilla_page_load_details 09:24:21 INFO - PROCESS | 28015 | |i|pagename|runs| 09:24:21 INFO - PROCESS | 28015 | |0;dojo.html;2558.245317631299;2600.5839065749483;2625.4355313607575;2628.1195799407196;2646.58977858432;4584.0602676451335;4667.393238878941;4718.834840780573;4737.763111844407;4752.405949256343;4681.297805329203;4699.741514216726;4706.50581688922;4733.053389322132;4743.667943243974;4299.333603291495;4346.326319420479;4349.412829268056;4349.717268377545;4452.421185245929;4409.096135292258;4409.603135717784;4414.315781053926;4431.313146462304;4445.777711114448;4295.978520107379;4340.13197360526;4398.868033958986;4439.533848945863;4466.33005049242;4392.428984232061;4392.472903251598;4399.538048504893;4401.779911004437;4404.251277282838;4361.520232774392;4366.716163449366;4370.300751879684;4371.650267978554;4373.081652852905;4674;4683.906321873544;4695.741734204617;4750.216214324632;4776.95223047772;5018.146915024455;5030.597552195853;5112.907556006312;5112.948870511322;5180.818671346522;4966.15575352191;5124.92312615311;5126.897462050738;5134.05020071288;5139.922901156486;4624.468186158601;4692.7653617319;4702.6708130431225;4734.26618874075;4736.502667219961;5170.896582068338;5193.350831146106;5198.870028249324;5206.427292997767;5273.288106105703;4823.831165909176;4982.476839931827;4983.476734942778;4986.276989836453;4987.326710894055;4993.725345105981;5021.824236151717;5054.974725126351;5064.164412871834;5145.76844042019;5024.145895197825;5038.924416133761;5041.571466425395;5047.242913562922;5103.591712662978;5016.924746128738;5028.094942910238;5029.321041659402;5033.697978121324;5093.18509038552;4202.831886724558;4227.556106608762;4233.936490952638;4245.61789438952;4246.363045543131;3689.7048236141045;3700.1489657378415;3746.250749850041;3752.080740218664;3769.509963704701;4318.287482565342;4322.351647252937;4329.653627709776;4371.978140109279;4378.036831896978;4992.101421744121;5014.874628134326;5053.84838454847;5053.974730126326;5062.4684408137355;4257.70196086271;4286.5070516890955;4300.548442413564;4321.049369138785;4348.195583817004;4546.318052292183;4550.590446859798;4584.541545845455;4603.58567728906;4608.2166031774;4658.673892827537;4673.182193116123;4677.672562920563;4679.1577516046755;4733.124371991193;4949.257611358325;4956.157453232887;5023.372078490189;5025.597952163745;5037.420696619789;4640.976795116003;4665.813367465264;4685.531446855287;4723.8819029523165;4725.220338644085;4932;4932.4081110267;4938.38270216223;4947.1589829729755;4997.300377947163;4875.780589873393;4878.341423907727;4996.100701873697;5016.949830501794;5076.6446348755235;4795.976020119877;4810.63920205993;4834.3231947528075;4852.344933433941;4921;4804.615630749601;4846.151923413318;4852.417709874838;4882.7558622068045;4910.558049775537;4661.137689527448;4807.519248075165;4809.711417314972;4830.3237546742785;4878.0975519529;4778.5699287064335;4801.7118972861745;4822.758862056813;4835.879103022453;4898.8775280618265;4723.929141062956;4728.196206644948;4735.550122738335;4736.526347365236;4787.736674482937 09:24:21 INFO - PROCESS | 28015 | |1;ext.html;562.4825160852018;563.7378618942192;569.2741754263313;572.1160806553873;572.6220694341736;27468.45063098737;36954;38386.8080659597;38564.80717596408;42633;39304.80347598258;39800.63688217675;39835.60164398355;39847.601523984755;39906.40140397896;7385.704571817134;7528.698852045912;7530.209328020561;7533.811654708648;7537.736179233728;7515.473916825825;7655.387568994467;7665.923340766604;7668.348190403823;7668.348190403823;7653.387728981696;7697.653605587734;7701.92048147;7702.191269916662;7706.422018348646;7659.544686509573;7703.537787732754;7712.383009359238;7720.266574675425;7721.53670779755;7606.201348858401;7671.3862890968585;7671.961640191764;7673.040869891263;7676.040494938133;37332.44001339982;37514.81242593797;37544;37574.624253757385;37619.62380376188;3016.3364059906785;3045.512717965115;3321.385543674428;3321.684439978222;3616.4936908832783;26010.6098408524;28334.574981375295;28863.855680721674;28880;28920.566191507143;3492;3546.964530354689;3623.8912832615065;3637.508936293593;3702.4631428442995;248263;248585;251456;252240;252736;53014;53232.73383633057;53298.733506332996;53365.46634533683;53424;55448.445515545136;55451.72274138684;55557.44442555604;55572;55624.44375556274;13537.255450950095;13715.519956801463;13726.86273137256;13761.449542018407;13761.793573096411;10195.949020254851;10197.337173083726;10198.745031374276;10202.081812636898;10236.078752912274;17059.573510662332;17586.97749758794;17609.7358539622;17611.207495662726;17735.82264177342;6709.832254193684;6716.83207919806;6833.592332945322;6849.2465828758795;6928.4018493065105;800.6837299266873;829.241244261494;865.9685291941656;875.7241468937265;978.0464047553578;27537.449251014867;27576.20899611104;28046.579301310496;28064.579031314548;28154;933.7852293972288;969.1326262994721;971.0386717149971;974.9220062394992;1021.5300961557766;13645.931770341085;14584.1978691173;14770.77843832322;14899.404023838924;15039.924800376148;352247;354607;355372;355782;355854;46907.76546117248;47529.287060694114;47562.28656570085;47568.762156189;47611.5238847614;1039.8076355874036;1092.4264761000538;1129.5143088472037;1176.088531388181;1177.988220117805;24549.50900982006;28071.157865264075;28095.859520703085;28591.559148919558;28820.567691484226;39998.80000599979;40501.1899762009;40501.39247911225;40529;40610;275027;275162;275332;276477;277398;21504.56990860143;22165.335039948826;23219.419514512272;24014;24430.26709198727;38899.22201555897;39073.609263907;39107;39199.608003919595;39382.60617393789;33792.83103584466;33847.49228761521;34136.31727365489;34178.48732269068;34184.316313674084;33665.66334336723;34098;34452.65547344595;34538.13654658654;35066;33747.3250534983;34078.82960585181;34117;34258.14354641154;34287.48568771421;29437.48906714595;30573.439436957688;31202;32037.199070023435;32140.19649508781;24870.37824054413;24892.626610600495;24927.626085609092;25041;25545.872270638527 09:24:21 INFO - PROCESS | 28015 | |2;jquery.html;361.84621535847276;362.5431955735773;362.55224797375246;377.6431272447538;384.8306745032186;15399.153046582433;16892.915535422322;17012.829871701295;17093.03430105538;17094.572635684082;15350.769738453931;15529.53411397657;15790.210489475508;16149.111798851058;16189.595260118504;4931.926021109686;5116.948830511685;5122.410922743877;5131.179011358184;5137.152369858969;3695.9630403696024;3775.5846856845724;4996.900061998758;5080.780612652955;5082.339295891547;4486;4590.42619672541;4599.724016559017;4611.76941152941;4622.329762184481;4591.173588754023;4597.471290801567;4598.310253461974;4607.746573938432;5672;5158.974205128988;5175.378954525443;5176.663516871391;5176.7411629418375;5179.585633149339;20094.598108037757;20776.68834967477;20875.791242087536;20957;21042.368728938156;1846.6952952762779;1927.816857398559;1936.3610008697096;1940.922363105474;1996.800319968006;12758.46898372192;13255.27096009719;13369.66575835602;13437.462501499927;13858.653533661638;1706.5051135170786;1762.207006846924;1774.609585891102;1789.055133430782;1800.216905646035;65939.67030164867;68002;68205;68627.3137268631;69383;9103.908960910307;9372.156505914363;9453.763655908657;9464.391053520918;9505.714828555154;13393.330333483482;13410.463581456828;13415.932920335532;13416;13436.596902092953;6844.247132815386;7027.641268576364;7137.500374973806;7187;7217.494775365779;6643.2360278568585;6654;6711.597304161766;6881.552699074644;6942.375186233263;5924.20023296858;6014.308354539196;6060.121282414026;6088.573799834057;6223.751049958041;1695.9406420775213;1701.8139064500629;1759.8240175982298;1769.5487650649259;1779.7063484524908;798.892149559802;812.4353574265829;818.2594751749676;837.5686521441462;878.8443197195795;16379.42672006498;17002.829971700372;17692.823071769373;17750.733738993924;18150.909245453953;822.8560001999626;881.9470831749987;889.0531583863294;906.2704522859029;915.4507295622573;9141.680041198526;9306.115918987685;9809.117179453884;9814.411135331902;9883.950580247196;167161;167498;170534;398791;404504.842330517;81019.59490202511;81358;81621.59189204135;82854.58572707219;83594.58202708948;890.8930928288647;905.5291248550849;931.8182954323977;932.4172392254841;941.0401390581568;15583.142927139117;15782.57956783895;16293.51119466418;16447.58881027936;16739.74890376621;35822.28355432929;37209.44185837269;37372;37852.43221351737;38140;46167;47606.761966189944;47650;52633;52969;7304.123505179413;7510.286522780327;7522;7742.458027937991;7875.448718589873;10888.67333979982;10985.725356866142;11207.887921121011;11487.36819474937;11777;9933.453660048477;10008.799824003625;10019.599216031276;10049.849252261369;10124.59501619927;10111.443870586894;10120.443375614412;10288.845667315147;10309.22680798958;10371.185042617662;9703.563339649874;9845.507724613884;9859;10041.04610062043;10229.261115087922;7418.406527477681;7506.43701722384;7525.134609519975;7580;7672.38620910337;9903.405795651996;9971.152452041657;10258.846117308396;10489.482524193985;10624.521896514521 09:24:21 INFO - PROCESS | 28015 | |3;mootools.html;1143.9828402573958;1372.2452651041924;1378.6208792582038;1474.4913005013273;1700.4473546097513;6758.189017317923;7371.483996120267;7639.579823109727;7695.961520192398;7831.099423566292;7730.65212065457;7801.9077329173815;7816.335611473031;7819.022622172229;7896.723614673488;2183.1267493002806;2208;2208.249195273607;2208.492046829222;2213.7232845894264;2154.1814110637933;2184.6067707812585;2212.668099785029;2214.424249695083;2218.190360518407;2162.362103179566;2171.6742488626674;2175.6845257437662;2191.9780802192013;2203.5482726041205;2150.5483848391855;2152.644813605761;2155.3103007037753;2159.5572907553915;2161.3299877038166;2051.8768873867616;2141.3254824730316;2149.269248455517;2150.193677370986;2152.591007708546;7508.136564295121;7767.572783496906;7800.531968081933;7819.413543984167;7831.295183433462;4443.133588950156;4642.141203877293;4642.442906851199;4650.534946505356;4654.953450465519;2861.570764385338;2980.8509574521404;3015.0804004778533;3025.6823033581377;3026.8335241561704;920.0983036624145;928.972130836076;930.483581612205;938.2306508662899;957.2103015012642;10514.526846291936;10615.46922653872;10617.522211500424;10620.787584248348;10634.415107169103;3999.900002499961;4129.525104613008;4138.275801734684;4224.577542245751;4317.266064768997;8319.334453243726;8352.540610266493;8402.663893444316;8407.579621019047;8415.579221038923;4550.158220729176;4551.362809206714;4555.681102322806;4559.247724125482;4563.931541026887;3664.2121943782213;3793.696504279706;4026.697997650188;4250.489941207075;4251.44731184944;3265.869365225364;3303.2732798784227;3407;3422.9144271392915;3440.2947395783804;965.7826988927435;970.5486948568808;973.153356579766;991.9107280344804;994.080475560104;707.2856415020763;719.9928000719925;774.5546310871272;816.510093943629;828.6166180902956;4896.608271338285;4938.950610493849;5022.372203474566;5138.3577052868395;5387.919181212285;409.36343985102855;410.73712823792795;410.9876703698894;417.54696154671916;419.5133644971879;3437.74216933731;3508.6315936826777;3515.9121021974142;3529.752917295816;3685.502457168248;9171.724848254564;9584.520773961274;9586.760330991641;9588.808223835484;9616.855747163798;9501.762455938657;9502.429854208769;9519.809603807886;9529.761755956019;9545.570449329658;7113.608751518716;7207.999999999895;7232.819179520448;7303.160136584254;7308.123025237006;5087.949120508895;5107.897842043064;5127.615428842926;5191.74041297926;5275.630705850554;8647.308215342884;8799.076097009722;8828.470291782514;8849.557522123996;8879.378443509151;8849.64601415962;8901.73294801157;9000.59497322635;9022.774430639287;9027.593758280762;5667.518260947865;6213.2233470816145;6265.937340626535;6270.216222972129;6282.780102696383;6825.453963682993;6908.792736217922;6969.477289203432;6975.476839236976;7294.489385742947;6610.867782644416;6629.867402652017;6650.667466626746;6680.365365290289;6695.230048544285;6517.608943463408;6576.309487503743;6610.537262391586;6655.73377064912;6669.599824010575;5992.49063829562;6043;6079.422454866781;6091.360407157362;6093.146959425772;4348.608625223745;4529;4533.977330113328;4619.630429565694;4644.953550464452;4383.561643835591;4456.5766252205985;4505.256632655575;4619.422572178478;4691.554302341272 09:24:21 INFO - PROCESS | 28015 | |4;prototype.html;287.41367610075446;294.4141159093404;294.5669865298012;299.46694883108074;300.1296240901384;4752.59602933751;4800.519948005198;4812.326274321589;4826.517348265176;4826.855194344166;4716.245400735883;4722.409698787652;4746.216874215759;4753.8811529711775;4764.309175169607;3521.1373213562715;3646.690031347339;3676;3676.761010534307;3679.356112680284;3637.94543081854;3670.743047986642;3733.5146430963937;3773.6792372648356;3774.41496568031;3713.554373475173;3720.665140137387;3726.441033844918;3751.6060813614586;3758.924821503568;3633.65480279373;3743.625637436262;3751.1747415568666;3757.3048985937553;3763.5860055393887;3306.6112232862015;3313.2379552702773;3317.154125697956;3319.93360132796;3336.115929278743;4619.19164146273;4637.536246375369;4648.74431906245;4663.347131401607;4672.766361681903;4257.61681448668;4258.6380157686635;4274.957250427487;4289.6353809926195;4294.613484786353;4779.474257831635;4904.9154109503315;4932.273704203536;4941.654084214107;4986.4764199758865;3516.82415879205;3523.894283171509;3523.9119022024397;3534.964650353489;3537.7523573349877;5181.300524429229;5259.368875734936;5264.105102132647;5274.868128296785;5285.154375299972;3541.3271478419533;3628.2017956049626;3639.4176931690804;3647.252313275772;3654.6162652921594;3669.9266014679556;3678.4666223397458;3682.392405253157;3684.9815750921075;3695.8748719486402;4206.221848957953;4219.177260434247;4223.345381465878;4242.8727138185905;4246.723962942398;4950.702957822542;4954.603631709455;4964.553190212898;4965.4289756678445;4993.101241776442;1185.875483074282;1238.7089034076985;1251.6995920979082;1262.9052821038458;1264.2604076615282;784.8901153838467;805.3677862877613;826.6401769089933;829.6059371798348;832.4547421438967;3927.23418933311;4193.454850869429;4321.286987647003;4330.198913201005;4332.631726303236;4976.601871850244;5113.15632920564;5120.667156634807;5127.53852153308;5150.407703114115;4356.041670832412;4374.934375984363;4388.517263101056;4411.625011874026;4423.650786510146;2642.6696662917134;2687.540900076408;2707.91876243713;2713.592961055818;2723.305557082931;4776.283557466339;4782.808687652455;4793.352897358882;4793.49668284832;4794.760261986887;5224.798296391851;5233.2935053768015;5243.397009343974;5260.395054568697;5270.341207349082;4620.792064357045;4699.389079419653;4732.834350797774;4753.857384278477;4774.809007639725;5089.872753181052;5094.159463688598;5120.4111527174855;5121.1550094234035;5129.487051294841;5016.974915125401;5027.366106015633;5031.169856973558;5043.773030213722;5060.746962651926;4507.240069631234;4653.045316224155;4732.432108147044;4755.762211889322;4756.191447453872;3576.5693722511205;3585.838637261277;3588.407912694376;3600.117971097098;3610.7833529988284;5134.717590532557;5139.974300128475;5155.922661160161;5156.793728250828;5158.509941555546;4742.553521176074;4811.109944660249;4840.878978025577;4879.219324908139;4926.236433352836;4857.95142048575;4863.513648635108;4869.780859861244;4875.634327425528;4881.731504767272;4784.47370789206;4806.149632391484;4830.9275360870315;4852;4883.755812209446;4656.604188644003;4728.101660684459;4903.828366007173;4918.2868484068895;4945.23348880924;4640.930386044144;4758.333833263415;4788.592969597623;4802.4957379476045;4805.327254184347 09:24:21 INFO - PROCESS | 28015 | |5;yui.html;607.8206928955957;713.3116542536451;730.4302643937727;761.8095476130967;762.4891322813711;12293.26240425574;13066;13427.597172084828;13468.932655336723;13699.589012329647;13038.869611303884;13240.205587664746;13305.268210248432;13307.334633268347;13316.400761965711;633.8478765096366;758.2682711183693;778.0740918307197;778.346189201071;780.4263866058443;541.656048409261;740.1377395334429;779.123486078162;784.7763387434583;787.6573690444646;827.6234313387424;830.1449507007792;830.5432012393189;830.5598033042497;830.6635812495949;643.65886080377;825.8678611422174;826.5164878546058;826.5164878546058;827.2513375395276;489.73309546297355;565.9349174844905;596.9761209551613;601.2064075420446;603.9063945088518;13183.406746696422;13210.471581136742;13227.470901163942;13233.735325293537;13249.60251192456;12063.336516491589;12533.373331333489;12777.936110319482;12931.741365172738;13264.336783160803;12113.454894529767;12140.696482587917;12233.694157646041;12243;12442.751144977141;4113.218488487208;4152.875413737593;4162.562930892243;4163.91672166558;4270.338097594878;62651;63278.683606581675;63308.683456582425;63910.0413493798;64056;10086.688730464992;10200.591976320864;10511.684649460376;10631.255812093079;10917.617883374203;20036.39890803278;20043.699344509845;20066.498337541678;20069.39791806248;20070.698939515918;6752.864942701217;6822.249552549216;6883.174019117738;7039.859202815915;7050.858982820418;3562.5012498250267;3572.1426857554;3599.6220396857952;3646.8176591170336;3678.411454167374;2941.7940744147704;3013.8945136920543;3053.2214285357536;3053.908382748521;3058.311879827021;495.841330774156;496.0277855403378;503.4436947173394;507.1049597460485;513.3403576404377;446.2948541304731;494.5796073337634;509.84194899580507;512.106374376715;542.1352942057412;6638.502112341594;6708.161479815023;7159.427245820322;7318.121825380988;7402.111746590336;508.92874997500377;513.6070905757099;515.5257163409672;518.9247559103909;529.1639210048191;3443.3113377324635;3493.7729047611824;3568.411212149966;3572.7499075065016;3644.3804553226014;100402;101889;102021;105033;105773.47113264384;88275;88344;89467.55266223627;90413.54793225991;90734;49888.75055624699;57233;77487.61256193682;78279.2172078272;78957.60521197472;6604.537682362188;6691.1636045494315;6772.966135169293;6851.143607049119;6964.338387853146;43588.46173073937;44574.3313850299;44944.55055449404;45399.319010215535;47037.76481117572;37052.25895482129;37513.249735005695;47079.52920470751;51829.740851297014;53775.193372100235;10260.897391026292;10508.054275115277;10523.894761052292;10593.152547796311;10605.25763196569;11850.585229516926;12139.150259481752;12267.815982760087;12370.876291236973;12545.87454125447;10820.350778953289;11078.11375090007;11239.66281011571;11315.886841131483;11407.714807129556;11565.884341156481;11588.246763960316;11652.184347095623;11678.06575473977;12509.249445033327;10597.25819192649;11050.502727377127;11538.59614913474;12157.574484892986;12243;8237.546934918637;8434.789130271547;8442.113578074213;8804.515751633466;8979.865302020344;8323;8924.509151996443;9023.954880225558;9025.638974440948;9093.318001149808 09:24:21 INFO - PROCESS | 28015 | __end_tp_report 09:24:21 INFO - PROCESS | 28015 | __start_cc_report 09:24:21 INFO - PROCESS | 28015 | _x_x_mozilla_cycle_collect,1082 09:24:21 INFO - PROCESS | 28015 | __end_cc_report 09:24:21 INFO - PROCESS | 28015 | __startTimestamp1475079861126__endTimestamp 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | ------- Summary: start ------- 09:24:21 INFO - PROCESS | 28015 | Number of tests: 6 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#0] dojo.html Cycles:165 Average:4649.94 Median:4735.55 stddev:484.32 (10.2%) stddev-sans-first:457.17 09:24:21 INFO - PROCESS | 28015 | Values: 2558.2 2600.6 2625.4 2628.1 2646.6 4584.1 4667.4 4718.8 4737.8 4752.4 4681.3 4699.7 4706.5 4733.1 4743.7 4299.3 4346.3 4349.4 4349.7 4452.4 4409.1 4409.6 4414.3 4431.3 4445.8 4296.0 4340.1 4398.9 4439.5 4466.3 4392.4 4392.5 4399.5 4401.8 4404.3 4361.5 4366.7 4370.3 4371.7 4373.1 4674.0 4683.9 4695.7 4750.2 4777.0 5018.1 5030.6 5112.9 5112.9 5180.8 4966.2 5124.9 5126.9 5134.1 5139.9 4624.5 4692.8 4702.7 4734.3 4736.5 5170.9 5193.4 5198.9 5206.4 5273.3 4823.8 4982.5 4983.5 4986.3 4987.3 4993.7 5021.8 5055.0 5064.2 5145.8 5024.1 5038.9 5041.6 5047.2 5103.6 5016.9 5028.1 5029.3 5033.7 5093.2 4202.8 4227.6 4233.9 4245.6 4246.4 3689.7 3700.1 3746.3 3752.1 3769.5 4318.3 4322.4 4329.7 4372.0 4378.0 4992.1 5014.9 5053.8 5054.0 5062.5 4257.7 4286.5 4300.5 4321.0 4348.2 4546.3 4550.6 4584.5 4603.6 4608.2 4658.7 4673.2 4677.7 4679.2 4733.1 4949.3 4956.2 5023.4 5025.6 5037.4 4641.0 4665.8 4685.5 4723.9 4725.2 4932.0 4932.4 4938.4 4947.2 4997.3 4875.8 4878.3 4996.1 5016.9 5076.6 4796.0 4810.6 4834.3 4852.3 4921.0 4804.6 4846.2 4852.4 4882.8 4910.6 4661.1 4807.5 4809.7 4830.3 4878.1 4778.6 4801.7 4822.8 4835.9 4898.9 4723.9 4728.2 4735.6 4736.5 4787.7 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#1] ext.html Cycles:180 Average:44665.81 Median:355577.00 stddev:78005.13 (21.9%) stddev-sans-first:78153.67 09:24:21 INFO - PROCESS | 28015 | Values: 562.5 563.7 569.3 572.1 572.6 27468.5 36954.0 38386.8 38564.8 42633.0 39304.8 39800.6 39835.6 39847.6 39906.4 7385.7 7528.7 7530.2 7533.8 7537.7 7515.5 7655.4 7665.9 7668.3 7668.3 7653.4 7697.7 7701.9 7702.2 7706.4 7659.5 7703.5 7712.4 7720.3 7721.5 7606.2 7671.4 7672.0 7673.0 7676.0 37332.4 37514.8 37544.0 37574.6 37619.6 3016.3 3045.5 3321.4 3321.7 3616.5 26010.6 28334.6 28863.9 28880.0 28920.6 3492.0 3547.0 3623.9 3637.5 3702.5 248263.0 248585.0 251456.0 252240.0 252736.0 53014.0 53232.7 53298.7 53365.5 53424.0 55448.4 55451.7 55557.4 55572.0 55624.4 13537.3 13715.5 13726.9 13761.4 13761.8 10195.9 10197.3 10198.7 10202.1 10236.1 17059.6 17587.0 17609.7 17611.2 17735.8 6709.8 6716.8 6833.6 6849.2 6928.4 800.7 829.2 866.0 875.7 978.0 27537.4 27576.2 28046.6 28064.6 28154.0 933.8 969.1 971.0 974.9 1021.5 13645.9 14584.2 14770.8 14899.4 15039.9 352247.0 354607.0 355372.0 355782.0 355854.0 46907.8 47529.3 47562.3 47568.8 47611.5 1039.8 1092.4 1129.5 1176.1 1178.0 24549.5 28071.2 28095.9 28591.6 28820.6 39998.8 40501.2 40501.4 40529.0 40610.0 275027.0 275162.0 275332.0 276477.0 277398.0 21504.6 22165.3 23219.4 24014.0 24430.3 38899.2 39073.6 39107.0 39199.6 39382.6 33792.8 33847.5 34136.3 34178.5 34184.3 33665.7 34098.0 34452.7 34538.1 35066.0 33747.3 34078.8 34117.0 34258.1 34287.5 29437.5 30573.4 31202.0 32037.2 32140.2 24870.4 24892.6 24927.6 25041.0 25545.9 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#2] jquery.html Cycles:180 Average:20845.19 Median:4599.02 stddev:48465.19 (1053.8%) stddev-sans-first:48576.74 09:24:21 INFO - PROCESS | 28015 | Values: 361.8 362.5 362.6 377.6 384.8 15399.2 16892.9 17012.8 17093.0 17094.6 15350.8 15529.5 15790.2 16149.1 16189.6 4931.9 5116.9 5122.4 5131.2 5137.2 3696.0 3775.6 4996.9 5080.8 5082.3 4486.0 4590.4 4599.7 4611.8 4622.3 4591.2 4597.5 4598.3 4607.7 5672.0 5159.0 5175.4 5176.7 5176.7 5179.6 20094.6 20776.7 20875.8 20957.0 21042.4 1846.7 1927.8 1936.4 1940.9 1996.8 12758.5 13255.3 13369.7 13437.5 13858.7 1706.5 1762.2 1774.6 1789.1 1800.2 65939.7 68002.0 68205.0 68627.3 69383.0 9103.9 9372.2 9453.8 9464.4 9505.7 13393.3 13410.5 13415.9 13416.0 13436.6 6844.2 7027.6 7137.5 7187.0 7217.5 6643.2 6654.0 6711.6 6881.6 6942.4 5924.2 6014.3 6060.1 6088.6 6223.8 1695.9 1701.8 1759.8 1769.5 1779.7 798.9 812.4 818.3 837.6 878.8 16379.4 17002.8 17692.8 17750.7 18150.9 822.9 881.9 889.1 906.3 915.5 9141.7 9306.1 9809.1 9814.4 9884.0 167161.0 167498.0 170534.0 398791.0 404504.8 81019.6 81358.0 81621.6 82854.6 83594.6 890.9 905.5 931.8 932.4 941.0 15583.1 15782.6 16293.5 16447.6 16739.7 35822.3 37209.4 37372.0 37852.4 38140.0 46167.0 47606.8 47650.0 52633.0 52969.0 7304.1 7510.3 7522.0 7742.5 7875.4 10888.7 10985.7 11207.9 11487.4 11777.0 9933.5 10008.8 10019.6 10049.8 10124.6 10111.4 10120.4 10288.8 10309.2 10371.2 9703.6 9845.5 9859.0 10041.0 10229.3 7418.4 7506.4 7525.1 7580.0 7672.4 9903.4 9971.2 10258.8 10489.5 10624.5 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#3] mootools.html Cycles:180 Average:5010.07 Median:5132.99 stddev:2837.35 (55.3%) stddev-sans-first:2830.43 09:24:21 INFO - PROCESS | 28015 | Values: 1144.0 1372.2 1378.6 1474.5 1700.4 6758.2 7371.5 7639.6 7696.0 7831.1 7730.7 7801.9 7816.3 7819.0 7896.7 2183.1 2208.0 2208.2 2208.5 2213.7 2154.2 2184.6 2212.7 2214.4 2218.2 2162.4 2171.7 2175.7 2192.0 2203.5 2150.5 2152.6 2155.3 2159.6 2161.3 2051.9 2141.3 2149.3 2150.2 2152.6 7508.1 7767.6 7800.5 7819.4 7831.3 4443.1 4642.1 4642.4 4650.5 4655.0 2861.6 2980.9 3015.1 3025.7 3026.8 920.1 929.0 930.5 938.2 957.2 10514.5 10615.5 10617.5 10620.8 10634.4 3999.9 4129.5 4138.3 4224.6 4317.3 8319.3 8352.5 8402.7 8407.6 8415.6 4550.2 4551.4 4555.7 4559.2 4563.9 3664.2 3793.7 4026.7 4250.5 4251.4 3265.9 3303.3 3407.0 3422.9 3440.3 965.8 970.5 973.2 991.9 994.1 707.3 720.0 774.6 816.5 828.6 4896.6 4939.0 5022.4 5138.4 5387.9 409.4 410.7 411.0 417.5 419.5 3437.7 3508.6 3515.9 3529.8 3685.5 9171.7 9584.5 9586.8 9588.8 9616.9 9501.8 9502.4 9519.8 9529.8 9545.6 7113.6 7208.0 7232.8 7303.2 7308.1 5087.9 5107.9 5127.6 5191.7 5275.6 8647.3 8799.1 8828.5 8849.6 8879.4 8849.6 8901.7 9000.6 9022.8 9027.6 5667.5 6213.2 6265.9 6270.2 6282.8 6825.5 6908.8 6969.5 6975.5 7294.5 6610.9 6629.9 6650.7 6680.4 6695.2 6517.6 6576.3 6610.5 6655.7 6669.6 5992.5 6043.0 6079.4 6091.4 6093.1 4348.6 4529.0 4534.0 4619.6 4645.0 4383.6 4456.6 4505.3 4619.4 4691.6 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#4] prototype.html Cycles:180 Average:4111.20 Median:4707.82 stddev:1192.96 (25.3%) stddev-sans-first:1161.27 09:24:21 INFO - PROCESS | 28015 | Values: 287.4 294.4 294.6 299.5 300.1 4752.6 4800.5 4812.3 4826.5 4826.9 4716.2 4722.4 4746.2 4753.9 4764.3 3521.1 3646.7 3676.0 3676.8 3679.4 3637.9 3670.7 3733.5 3773.7 3774.4 3713.6 3720.7 3726.4 3751.6 3758.9 3633.7 3743.6 3751.2 3757.3 3763.6 3306.6 3313.2 3317.2 3319.9 3336.1 4619.2 4637.5 4648.7 4663.3 4672.8 4257.6 4258.6 4275.0 4289.6 4294.6 4779.5 4904.9 4932.3 4941.7 4986.5 3516.8 3523.9 3523.9 3535.0 3537.8 5181.3 5259.4 5264.1 5274.9 5285.2 3541.3 3628.2 3639.4 3647.3 3654.6 3669.9 3678.5 3682.4 3685.0 3695.9 4206.2 4219.2 4223.3 4242.9 4246.7 4950.7 4954.6 4964.6 4965.4 4993.1 1185.9 1238.7 1251.7 1262.9 1264.3 784.9 805.4 826.6 829.6 832.5 3927.2 4193.5 4321.3 4330.2 4332.6 4976.6 5113.2 5120.7 5127.5 5150.4 4356.0 4374.9 4388.5 4411.6 4423.7 2642.7 2687.5 2707.9 2713.6 2723.3 4776.3 4782.8 4793.4 4793.5 4794.8 5224.8 5233.3 5243.4 5260.4 5270.3 4620.8 4699.4 4732.8 4753.9 4774.8 5089.9 5094.2 5120.4 5121.2 5129.5 5017.0 5027.4 5031.2 5043.8 5060.7 4507.2 4653.0 4732.4 4755.8 4756.2 3576.6 3585.8 3588.4 3600.1 3610.8 5134.7 5140.0 5155.9 5156.8 5158.5 4742.6 4811.1 4840.9 4879.2 4926.2 4858.0 4863.5 4869.8 4875.6 4881.7 4784.5 4806.1 4830.9 4852.0 4883.8 4656.6 4728.1 4903.8 4918.3 4945.2 4640.9 4758.3 4788.6 4802.5 4805.3 09:24:21 INFO - PROCESS | 28015 | 09:24:21 INFO - PROCESS | 28015 | [#5] yui.html Cycles:180 Average:17378.72 Median:45171.93 stddev:25405.45 (56.2%) stddev-sans-first:25445.51 09:24:21 INFO - PROCESS | 28015 | Values: 607.8 713.3 730.4 761.8 762.5 12293.3 13066.0 13427.6 13468.9 13699.6 13038.9 13240.2 13305.3 13307.3 13316.4 633.8 758.3 778.1 778.3 780.4 541.7 740.1 779.1 784.8 787.7 827.6 830.1 830.5 830.6 830.7 643.7 825.9 826.5 826.5 827.3 489.7 565.9 597.0 601.2 603.9 13183.4 13210.5 13227.5 13233.7 13249.6 12063.3 12533.4 12777.9 12931.7 13264.3 12113.5 12140.7 12233.7 12243.0 12442.8 4113.2 4152.9 4162.6 4163.9 4270.3 62651.0 63278.7 63308.7 63910.0 64056.0 10086.7 10200.6 10511.7 10631.3 10917.6 20036.4 20043.7 20066.5 20069.4 20070.7 6752.9 6822.2 6883.2 7039.9 7050.9 3562.5 3572.1 3599.6 3646.8 3678.4 2941.8 3013.9 3053.2 3053.9 3058.3 495.8 496.0 503.4 507.1 513.3 446.3 494.6 509.8 512.1 542.1 6638.5 6708.2 7159.4 7318.1 7402.1 508.9 513.6 515.5 518.9 529.2 3443.3 3493.8 3568.4 3572.7 3644.4 100402.0 101889.0 102021.0 105033.0 105773.5 88275.0 88344.0 89467.6 90413.5 90734.0 49888.8 57233.0 77487.6 78279.2 78957.6 6604.5 6691.2 6773.0 6851.1 6964.3 43588.5 44574.3 44944.6 45399.3 47037.8 37052.3 37513.2 47079.5 51829.7 53775.2 10260.9 10508.1 10523.9 10593.2 10605.3 11850.6 12139.2 12267.8 12370.9 12545.9 10820.4 11078.1 11239.7 11315.9 11407.7 11565.9 11588.2 11652.2 11678.1 12509.2 10597.3 11050.5 11538.6 12157.6 12243.0 8237.5 8434.8 8442.1 8804.5 8979.9 8323.0 8924.5 9024.0 9025.6 9093.3 09:24:21 INFO - PROCESS | 28015 | -------- Summary: end -------- 09:24:21 INFO - PROCESS | 28015 | 09:24:22 INFO - TEST-INFO | 28015: exit 0 09:24:22 INFO - TEST-OK | dromaeo_css | took 1121535ms 09:24:22 INFO - TEST-START | kraken 09:24:22 INFO - operating with platform_type : linux_ 09:24:22 INFO - Initialising browser for kraken test... 09:24:22 INFO - TEST-INFO | started process 28317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKcfhA/profile http://localhost:46026/getInfo.html) 09:24:26 INFO - PROCESS | 28317 | __metrics Screen width/height:1600/1200 09:24:26 INFO - PROCESS | 28317 | colorDepth:24 09:24:26 INFO - PROCESS | 28317 | Browser inner width/height: 1024/697 09:24:26 INFO - PROCESS | 28317 | __metrics 09:24:27 INFO - PROCESS | 28317 | 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" 09:24:27 INFO - PROCESS | 28317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:27 INFO - PROCESS | 28317 | console.error: PushService: 09:24:27 INFO - PROCESS | 28317 | stateChangeProcessEnqueue: Error transitioning state 09:24:27 INFO - PROCESS | 28317 | UnknownError 09:24:28 INFO - TEST-INFO | 28317: exit 0 09:24:28 INFO - Browser initialized. 09:24:28 INFO - Running cycle 1/1 for kraken test... 09:24:28 INFO - TEST-INFO | started process 28400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKcfhA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:40 INFO - PROCESS | 28400 | RSS: Main: 175267840 09:24:40 INFO - PROCESS | 28400 | 09:24:43 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:44 INFO - PROCESS | 28400 | RSS: Main: 234250240 09:24:44 INFO - PROCESS | 28400 | 09:24:47 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-dft) 09:24:48 INFO - PROCESS | 28400 | RSS: Main: 218562560 09:24:48 INFO - PROCESS | 28400 | 09:24:51 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-fft) 09:24:51 INFO - PROCESS | 28400 | RSS: Main: 300900352 09:24:51 INFO - PROCESS | 28400 | 09:24:54 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-oscillator) 09:24:54 INFO - PROCESS | 28400 | RSS: Main: 210259968 09:24:54 INFO - PROCESS | 28400 | 09:24:56 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:57 INFO - PROCESS | 28400 | RSS: Main: 214196224 09:24:57 INFO - PROCESS | 28400 | 09:25:00 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:01 INFO - PROCESS | 28400 | RSS: Main: 251006976 09:25:01 INFO - PROCESS | 28400 | 09:25:04 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:05 INFO - PROCESS | 28400 | RSS: Main: 250245120 09:25:05 INFO - PROCESS | 28400 | 09:25:08 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46026/tests/kraken/driver.html?testName=json-parse-financial) 09:25:08 INFO - PROCESS | 28400 | RSS: Main: 249757696 09:25:08 INFO - PROCESS | 28400 | 09:25:10 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:11 INFO - PROCESS | 28400 | RSS: Main: 212058112 09:25:11 INFO - PROCESS | 28400 | 09:25:13 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:13 INFO - PROCESS | 28400 | RSS: Main: 219574272 09:25:13 INFO - PROCESS | 28400 | 09:25:15 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:16 INFO - PROCESS | 28400 | RSS: Main: 223571968 09:25:16 INFO - PROCESS | 28400 | 09:25:19 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:19 INFO - PROCESS | 28400 | RSS: Main: 224477184 09:25:19 INFO - PROCESS | 28400 | 09:25:22 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:23 INFO - PROCESS | 28400 | RSS: Main: 222560256 09:25:23 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46026/tests/kraken/driver.html?testName=ai-astar) 09:25:25 INFO - PROCESS | 28400 | RSS: Main: 273555456 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | __start_tp_report 09:25:25 INFO - PROCESS | 28400 | _x_x_mozilla_page_load 09:25:25 INFO - PROCESS | 28400 | _x_x_mozilla_page_load_details 09:25:25 INFO - PROCESS | 28400 | |i|pagename|runs| 09:25:25 INFO - PROCESS | 28400 | |0;ai-astar;110;114;114;113;115;113;113;112;113;113 09:25:25 INFO - PROCESS | 28400 | |1;audio-beat-detection;153;130;131;171;124;132;130;126;174;132 09:25:25 INFO - PROCESS | 28400 | |2;audio-dft;161;163;162;162;162;161;162;162;162;160 09:25:25 INFO - PROCESS | 28400 | |3;audio-fft;76;76;77;107;77;77;77;77;99;76 09:25:25 INFO - PROCESS | 28400 | |4;audio-oscillator;84;84;113;85;86;84;107;85;84;122 09:25:25 INFO - PROCESS | 28400 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;118;118;119 09:25:25 INFO - PROCESS | 28400 | |6;imaging-darkroom;149;146;147;146;148;146;146;147;146;146 09:25:25 INFO - PROCESS | 28400 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;96;95 09:25:25 INFO - PROCESS | 28400 | |8;json-parse-financial;64;62;62;62;63;64;65;65;63;64 09:25:25 INFO - PROCESS | 28400 | |9;json-stringify-tinderbox;66;67;66;67;67;67;66;67;67;68 09:25:25 INFO - PROCESS | 28400 | |10;stanford-crypto-aes;82;83;91;89;83;89;82;83;92;82 09:25:25 INFO - PROCESS | 28400 | |11;stanford-crypto-ccm;143;135;140;132;130;134;133;136;173;134 09:25:25 INFO - PROCESS | 28400 | |12;stanford-crypto-pbkdf2;176;173;175;173;170;170;175;174;179;176 09:25:25 INFO - PROCESS | 28400 | |13;stanford-crypto-sha256-iterative;70;70;68;72;70;67;68;67;68;68 09:25:25 INFO - PROCESS | 28400 | __end_tp_report 09:25:25 INFO - PROCESS | 28400 | __start_cc_report 09:25:25 INFO - PROCESS | 28400 | _x_x_mozilla_cycle_collect,1919 09:25:25 INFO - PROCESS | 28400 | __end_cc_report 09:25:25 INFO - PROCESS | 28400 | __startTimestamp1475079925510__endTimestamp 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | ------- Summary: start ------- 09:25:25 INFO - PROCESS | 28400 | Number of tests: 14 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 09:25:25 INFO - PROCESS | 28400 | Values: 110.0 114.0 114.0 113.0 115.0 113.0 113.0 112.0 113.0 113.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:132.00 stddev:18.70 (14.2%) stddev-sans-first:19.26 09:25:25 INFO - PROCESS | 28400 | Values: 153.0 130.0 131.0 171.0 124.0 132.0 130.0 126.0 174.0 132.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 09:25:25 INFO - PROCESS | 28400 | Values: 161.0 163.0 162.0 162.0 162.0 161.0 162.0 162.0 162.0 160.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.29 (14.7%) stddev-sans-first:11.77 09:25:25 INFO - PROCESS | 28400 | Values: 76.0 76.0 77.0 107.0 77.0 77.0 77.0 77.0 99.0 76.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.00 stddev:14.67 (17.5%) stddev-sans-first:15.16 09:25:25 INFO - PROCESS | 28400 | Values: 84.0 84.0 113.0 85.0 86.0 84.0 107.0 85.0 84.0 122.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:25:25 INFO - PROCESS | 28400 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 119.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:0.73 09:25:25 INFO - PROCESS | 28400 | Values: 149.0 146.0 147.0 146.0 148.0 146.0 146.0 147.0 146.0 146.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:25:25 INFO - PROCESS | 28400 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.22 09:25:25 INFO - PROCESS | 28400 | Values: 64.0 62.0 62.0 62.0 63.0 64.0 65.0 65.0 63.0 64.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 09:25:25 INFO - PROCESS | 28400 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 68.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:4.12 (4.8%) stddev-sans-first:4.15 09:25:25 INFO - PROCESS | 28400 | Values: 82.0 83.0 91.0 89.0 83.0 89.0 82.0 83.0 92.0 82.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.50 stddev:12.53 (9.3%) stddev-sans-first:13.21 09:25:25 INFO - PROCESS | 28400 | Values: 143.0 135.0 140.0 132.0 130.0 134.0 133.0 136.0 173.0 134.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:175.00 stddev:2.77 (1.6%) stddev-sans-first:2.85 09:25:25 INFO - PROCESS | 28400 | Values: 176.0 173.0 175.0 173.0 170.0 170.0 175.0 174.0 179.0 176.0 09:25:25 INFO - PROCESS | 28400 | 09:25:25 INFO - PROCESS | 28400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.66 09:25:25 INFO - PROCESS | 28400 | Values: 70.0 70.0 68.0 72.0 70.0 67.0 68.0 67.0 68.0 68.0 09:25:25 INFO - PROCESS | 28400 | -------- Summary: end -------- 09:25:25 INFO - PROCESS | 28400 | 09:25:26 INFO - TEST-INFO | 28400: exit 0 09:25:27 INFO - TEST-OK | kraken | took 64894ms 09:25:27 INFO - SUITE-END | took 1186s 09:25:27 INFO - Completed test suite (00:19:46) 09:25:27 INFO - javascript benchmark 09:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.245317631299, 2600.5839065749483, 2625.4355313607575, 2628.1195799407196, 2646.58977858432, 4584.0602676451335, 4667.393238878941, 4718.834840780573, 4737.763111844407, 4752.405949256343, 4681.297805329203, 4699.741514216726, 4706.50581688922, 4733.053389322132, 4743.667943243974, 4299.333603291495, 4346.326319420479, 4349.412829268056, 4349.717268377545, 4452.421185245929, 4409.096135292258, 4409.603135717784, 4414.315781053926, 4431.313146462304, 4445.777711114448, 4295.978520107379, 4340.13197360526, 4398.868033958986, 4439.533848945863, 4466.33005049242, 4392.428984232061, 4392.472903251598, 4399.538048504893, 4401.779911004437, 4404.251277282838, 4361.520232774392, 4366.716163449366, 4370.300751879684, 4371.650267978554, 4373.081652852905, 4674.0, 4683.906321873544, 4695.741734204617, 4750.216214324632, 4776.95223047772, 5018.146915024455, 5030.597552195853, 5112.907556006312, 5112.948870511322, 5180.818671346522, 4966.15575352191, 5124.92312615311, 5126.897462050738, 5134.05020071288, 5139.922901156486, 4624.468186158601, 4692.7653617319, 4702.6708130431225, 4734.26618874075, 4736.502667219961, 5170.896582068338, 5193.350831146106, 5198.870028249324, 5206.427292997767, 5273.288106105703, 4823.831165909176, 4982.476839931827, 4983.476734942778, 4986.276989836453, 4987.326710894055, 4993.725345105981, 5021.824236151717, 5054.974725126351, 5064.164412871834, 5145.76844042019, 5024.145895197825, 5038.924416133761, 5041.571466425395, 5047.242913562922, 5103.591712662978, 5016.924746128738, 5028.094942910238, 5029.321041659402, 5033.697978121324, 5093.18509038552, 4202.831886724558, 4227.556106608762, 4233.936490952638, 4245.61789438952, 4246.363045543131, 3689.7048236141045, 3700.1489657378415, 3746.250749850041, 3752.080740218664, 3769.509963704701, 4318.287482565342, 4322.351647252937, 4329.653627709776, 4371.978140109279, 4378.036831896978, 4992.101421744121, 5014.874628134326, 5053.84838454847, 5053.974730126326, 5062.4684408137355, 4257.70196086271, 4286.5070516890955, 4300.548442413564, 4321.049369138785, 4348.195583817004, 4546.318052292183, 4550.590446859798, 4584.541545845455, 4603.58567728906, 4608.2166031774, 4658.673892827537, 4673.182193116123, 4677.672562920563, 4679.1577516046755, 4733.124371991193, 4949.257611358325, 4956.157453232887, 5023.372078490189, 5025.597952163745, 5037.420696619789, 4640.976795116003, 4665.813367465264, 4685.531446855287, 4723.8819029523165, 4725.220338644085, 4932.0, 4932.4081110267, 4938.38270216223, 4947.1589829729755, 4997.300377947163, 4875.780589873393, 4878.341423907727, 4996.100701873697, 5016.949830501794, 5076.6446348755235, 4795.976020119877, 4810.63920205993, 4834.3231947528075, 4852.344933433941, 4921.0, 4804.615630749601, 4846.151923413318, 4852.417709874838, 4882.7558622068045, 4910.558049775537, 4661.137689527448, 4807.519248075165, 4809.711417314972, 4830.3237546742785, 4878.0975519529, 4778.5699287064335, 4801.7118972861745, 4822.758862056813, 4835.879103022453, 4898.8775280618265, 4723.929141062956, 4728.196206644948, 4735.550122738335, 4736.526347365236, 4787.736674482937], "value": 4618.9771906598335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4825160852018, 563.7378618942192, 569.2741754263313, 572.1160806553873, 572.6220694341736, 27468.45063098737, 36954.0, 38386.8080659597, 38564.80717596408, 42633.0, 39304.80347598258, 39800.63688217675, 39835.60164398355, 39847.601523984755, 39906.40140397896, 7385.704571817134, 7528.698852045912, 7530.209328020561, 7533.811654708648, 7537.736179233728, 7515.473916825825, 7655.387568994467, 7665.923340766604, 7668.348190403823, 7668.348190403823, 7653.387728981696, 7697.653605587734, 7701.92048147, 7702.191269916662, 7706.422018348646, 7659.544686509573, 7703.537787732754, 7712.383009359238, 7720.266574675425, 7721.53670779755, 7606.201348858401, 7671.3862890968585, 7671.961640191764, 7673.040869891263, 7676.040494938133, 37332.44001339982, 37514.81242593797, 37544.0, 37574.624253757385, 37619.62380376188, 3016.3364059906785, 3045.512717965115, 3321.385543674428, 3321.684439978222, 3616.4936908832783, 26010.6098408524, 28334.574981375295, 28863.855680721674, 28880.0, 28920.566191507143, 3492.0, 3546.964530354689, 3623.8912832615065, 3637.508936293593, 3702.4631428442995, 248263.0, 248585.0, 251456.0, 252240.0, 252736.0, 53014.0, 53232.73383633057, 53298.733506332996, 53365.46634533683, 53424.0, 55448.445515545136, 55451.72274138684, 55557.44442555604, 55572.0, 55624.44375556274, 13537.255450950095, 13715.519956801463, 13726.86273137256, 13761.449542018407, 13761.793573096411, 10195.949020254851, 10197.337173083726, 10198.745031374276, 10202.081812636898, 10236.078752912274, 17059.573510662332, 17586.97749758794, 17609.7358539622, 17611.207495662726, 17735.82264177342, 6709.832254193684, 6716.83207919806, 6833.592332945322, 6849.2465828758795, 6928.4018493065105, 800.6837299266873, 829.241244261494, 865.9685291941656, 875.7241468937265, 978.0464047553578, 27537.449251014867, 27576.20899611104, 28046.579301310496, 28064.579031314548, 28154.0, 933.7852293972288, 969.1326262994721, 971.0386717149971, 974.9220062394992, 1021.5300961557766, 13645.931770341085, 14584.1978691173, 14770.77843832322, 14899.404023838924, 15039.924800376148, 352247.0, 354607.0, 355372.0, 355782.0, 355854.0, 46907.76546117248, 47529.287060694114, 47562.28656570085, 47568.762156189, 47611.5238847614, 1039.8076355874036, 1092.4264761000538, 1129.5143088472037, 1176.088531388181, 1177.988220117805, 24549.50900982006, 28071.157865264075, 28095.859520703085, 28591.559148919558, 28820.567691484226, 39998.80000599979, 40501.1899762009, 40501.39247911225, 40529.0, 40610.0, 275027.0, 275162.0, 275332.0, 276477.0, 277398.0, 21504.56990860143, 22165.335039948826, 23219.419514512272, 24014.0, 24430.26709198727, 38899.22201555897, 39073.609263907, 39107.0, 39199.608003919595, 39382.60617393789, 33792.83103584466, 33847.49228761521, 34136.31727365489, 34178.48732269068, 34184.316313674084, 33665.66334336723, 34098.0, 34452.65547344595, 34538.13654658654, 35066.0, 33747.3250534983, 34078.82960585181, 34117.0, 34258.14354641154, 34287.48568771421, 29437.48906714595, 30573.439436957688, 31202.0, 32037.199070023435, 32140.19649508781, 24870.37824054413, 24892.626610600495, 24927.626085609092, 25041.0, 25545.872270638527], "value": 16975.40958216043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.84621535847276, 362.5431955735773, 362.55224797375246, 377.6431272447538, 384.8306745032186, 15399.153046582433, 16892.915535422322, 17012.829871701295, 17093.03430105538, 17094.572635684082, 15350.769738453931, 15529.53411397657, 15790.210489475508, 16149.111798851058, 16189.595260118504, 4931.926021109686, 5116.948830511685, 5122.410922743877, 5131.179011358184, 5137.152369858969, 3695.9630403696024, 3775.5846856845724, 4996.900061998758, 5080.780612652955, 5082.339295891547, 4486.0, 4590.42619672541, 4599.724016559017, 4611.76941152941, 4622.329762184481, 4591.173588754023, 4597.471290801567, 4598.310253461974, 4607.746573938432, 5672.0, 5158.974205128988, 5175.378954525443, 5176.663516871391, 5176.7411629418375, 5179.585633149339, 20094.598108037757, 20776.68834967477, 20875.791242087536, 20957.0, 21042.368728938156, 1846.6952952762779, 1927.816857398559, 1936.3610008697096, 1940.922363105474, 1996.800319968006, 12758.46898372192, 13255.27096009719, 13369.66575835602, 13437.462501499927, 13858.653533661638, 1706.5051135170786, 1762.207006846924, 1774.609585891102, 1789.055133430782, 1800.216905646035, 65939.67030164867, 68002.0, 68205.0, 68627.3137268631, 69383.0, 9103.908960910307, 9372.156505914363, 9453.763655908657, 9464.391053520918, 9505.714828555154, 13393.330333483482, 13410.463581456828, 13415.932920335532, 13416.0, 13436.596902092953, 6844.247132815386, 7027.641268576364, 7137.500374973806, 7187.0, 7217.494775365779, 6643.2360278568585, 6654.0, 6711.597304161766, 6881.552699074644, 6942.375186233263, 5924.20023296858, 6014.308354539196, 6060.121282414026, 6088.573799834057, 6223.751049958041, 1695.9406420775213, 1701.8139064500629, 1759.8240175982298, 1769.5487650649259, 1779.7063484524908, 798.892149559802, 812.4353574265829, 818.2594751749676, 837.5686521441462, 878.8443197195795, 16379.42672006498, 17002.829971700372, 17692.823071769373, 17750.733738993924, 18150.909245453953, 822.8560001999626, 881.9470831749987, 889.0531583863294, 906.2704522859029, 915.4507295622573, 9141.680041198526, 9306.115918987685, 9809.117179453884, 9814.411135331902, 9883.950580247196, 167161.0, 167498.0, 170534.0, 398791.0, 404504.842330517, 81019.59490202511, 81358.0, 81621.59189204135, 82854.58572707219, 83594.58202708948, 890.8930928288647, 905.5291248550849, 931.8182954323977, 932.4172392254841, 941.0401390581568, 15583.142927139117, 15782.57956783895, 16293.51119466418, 16447.58881027936, 16739.74890376621, 35822.28355432929, 37209.44185837269, 37372.0, 37852.43221351737, 38140.0, 46167.0, 47606.761966189944, 47650.0, 52633.0, 52969.0, 7304.123505179413, 7510.286522780327, 7522.0, 7742.458027937991, 7875.448718589873, 10888.67333979982, 10985.725356866142, 11207.887921121011, 11487.36819474937, 11777.0, 9933.453660048477, 10008.799824003625, 10019.599216031276, 10049.849252261369, 10124.59501619927, 10111.443870586894, 10120.443375614412, 10288.845667315147, 10309.22680798958, 10371.185042617662, 9703.563339649874, 9845.507724613884, 9859.0, 10041.04610062043, 10229.261115087922, 7418.406527477681, 7506.43701722384, 7525.134609519975, 7580.0, 7672.38620910337, 9903.405795651996, 9971.152452041657, 10258.846117308396, 10489.482524193985, 10624.521896514521], "value": 8101.781193073266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.9828402573958, 1372.2452651041924, 1378.6208792582038, 1474.4913005013273, 1700.4473546097513, 6758.189017317923, 7371.483996120267, 7639.579823109727, 7695.961520192398, 7831.099423566292, 7730.65212065457, 7801.9077329173815, 7816.335611473031, 7819.022622172229, 7896.723614673488, 2183.1267493002806, 2208.0, 2208.249195273607, 2208.492046829222, 2213.7232845894264, 2154.1814110637933, 2184.6067707812585, 2212.668099785029, 2214.424249695083, 2218.190360518407, 2162.362103179566, 2171.6742488626674, 2175.6845257437662, 2191.9780802192013, 2203.5482726041205, 2150.5483848391855, 2152.644813605761, 2155.3103007037753, 2159.5572907553915, 2161.3299877038166, 2051.8768873867616, 2141.3254824730316, 2149.269248455517, 2150.193677370986, 2152.591007708546, 7508.136564295121, 7767.572783496906, 7800.531968081933, 7819.413543984167, 7831.295183433462, 4443.133588950156, 4642.141203877293, 4642.442906851199, 4650.534946505356, 4654.953450465519, 2861.570764385338, 2980.8509574521404, 3015.0804004778533, 3025.6823033581377, 3026.8335241561704, 920.0983036624145, 928.972130836076, 930.483581612205, 938.2306508662899, 957.2103015012642, 10514.526846291936, 10615.46922653872, 10617.522211500424, 10620.787584248348, 10634.415107169103, 3999.900002499961, 4129.525104613008, 4138.275801734684, 4224.577542245751, 4317.266064768997, 8319.334453243726, 8352.540610266493, 8402.663893444316, 8407.579621019047, 8415.579221038923, 4550.158220729176, 4551.362809206714, 4555.681102322806, 4559.247724125482, 4563.931541026887, 3664.2121943782213, 3793.696504279706, 4026.697997650188, 4250.489941207075, 4251.44731184944, 3265.869365225364, 3303.2732798784227, 3407.0, 3422.9144271392915, 3440.2947395783804, 965.7826988927435, 970.5486948568808, 973.153356579766, 991.9107280344804, 994.080475560104, 707.2856415020763, 719.9928000719925, 774.5546310871272, 816.510093943629, 828.6166180902956, 4896.608271338285, 4938.950610493849, 5022.372203474566, 5138.3577052868395, 5387.919181212285, 409.36343985102855, 410.73712823792795, 410.9876703698894, 417.54696154671916, 419.5133644971879, 3437.74216933731, 3508.6315936826777, 3515.9121021974142, 3529.752917295816, 3685.502457168248, 9171.724848254564, 9584.520773961274, 9586.760330991641, 9588.808223835484, 9616.855747163798, 9501.762455938657, 9502.429854208769, 9519.809603807886, 9529.761755956019, 9545.570449329658, 7113.608751518716, 7207.999999999895, 7232.819179520448, 7303.160136584254, 7308.123025237006, 5087.949120508895, 5107.897842043064, 5127.615428842926, 5191.74041297926, 5275.630705850554, 8647.308215342884, 8799.076097009722, 8828.470291782514, 8849.557522123996, 8879.378443509151, 8849.64601415962, 8901.73294801157, 9000.59497322635, 9022.774430639287, 9027.593758280762, 5667.518260947865, 6213.2233470816145, 6265.937340626535, 6270.216222972129, 6282.780102696383, 6825.453963682993, 6908.792736217922, 6969.477289203432, 6975.476839236976, 7294.489385742947, 6610.867782644416, 6629.867402652017, 6650.667466626746, 6680.365365290289, 6695.230048544285, 6517.608943463408, 6576.309487503743, 6610.537262391586, 6655.73377064912, 6669.599824010575, 5992.49063829562, 6043.0, 6079.422454866781, 6091.360407157362, 6093.146959425772, 4348.608625223745, 4529.0, 4533.977330113328, 4619.630429565694, 4644.953550464452, 4383.561643835591, 4456.5766252205985, 4505.256632655575, 4619.422572178478, 4691.554302341272], "value": 3955.936679939153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.41367610075446, 294.4141159093404, 294.5669865298012, 299.46694883108074, 300.1296240901384, 4752.59602933751, 4800.519948005198, 4812.326274321589, 4826.517348265176, 4826.855194344166, 4716.245400735883, 4722.409698787652, 4746.216874215759, 4753.8811529711775, 4764.309175169607, 3521.1373213562715, 3646.690031347339, 3676.0, 3676.761010534307, 3679.356112680284, 3637.94543081854, 3670.743047986642, 3733.5146430963937, 3773.6792372648356, 3774.41496568031, 3713.554373475173, 3720.665140137387, 3726.441033844918, 3751.6060813614586, 3758.924821503568, 3633.65480279373, 3743.625637436262, 3751.1747415568666, 3757.3048985937553, 3763.5860055393887, 3306.6112232862015, 3313.2379552702773, 3317.154125697956, 3319.93360132796, 3336.115929278743, 4619.19164146273, 4637.536246375369, 4648.74431906245, 4663.347131401607, 4672.766361681903, 4257.61681448668, 4258.6380157686635, 4274.957250427487, 4289.6353809926195, 4294.613484786353, 4779.474257831635, 4904.9154109503315, 4932.273704203536, 4941.654084214107, 4986.4764199758865, 3516.82415879205, 3523.894283171509, 3523.9119022024397, 3534.964650353489, 3537.7523573349877, 5181.300524429229, 5259.368875734936, 5264.105102132647, 5274.868128296785, 5285.154375299972, 3541.3271478419533, 3628.2017956049626, 3639.4176931690804, 3647.252313275772, 3654.6162652921594, 3669.9266014679556, 3678.4666223397458, 3682.392405253157, 3684.9815750921075, 3695.8748719486402, 4206.221848957953, 4219.177260434247, 4223.345381465878, 4242.8727138185905, 4246.723962942398, 4950.702957822542, 4954.603631709455, 4964.553190212898, 4965.4289756678445, 4993.101241776442, 1185.875483074282, 1238.7089034076985, 1251.6995920979082, 1262.9052821038458, 1264.2604076615282, 784.8901153838467, 805.3677862877613, 826.6401769089933, 829.6059371798348, 832.4547421438967, 3927.23418933311, 4193.454850869429, 4321.286987647003, 4330.198913201005, 4332.631726303236, 4976.601871850244, 5113.15632920564, 5120.667156634807, 5127.53852153308, 5150.407703114115, 4356.041670832412, 4374.934375984363, 4388.517263101056, 4411.625011874026, 4423.650786510146, 2642.6696662917134, 2687.540900076408, 2707.91876243713, 2713.592961055818, 2723.305557082931, 4776.283557466339, 4782.808687652455, 4793.352897358882, 4793.49668284832, 4794.760261986887, 5224.798296391851, 5233.2935053768015, 5243.397009343974, 5260.395054568697, 5270.341207349082, 4620.792064357045, 4699.389079419653, 4732.834350797774, 4753.857384278477, 4774.809007639725, 5089.872753181052, 5094.159463688598, 5120.4111527174855, 5121.1550094234035, 5129.487051294841, 5016.974915125401, 5027.366106015633, 5031.169856973558, 5043.773030213722, 5060.746962651926, 4507.240069631234, 4653.045316224155, 4732.432108147044, 4755.762211889322, 4756.191447453872, 3576.5693722511205, 3585.838637261277, 3588.407912694376, 3600.117971097098, 3610.7833529988284, 5134.717590532557, 5139.974300128475, 5155.922661160161, 5156.793728250828, 5158.509941555546, 4742.553521176074, 4811.109944660249, 4840.878978025577, 4879.219324908139, 4926.236433352836, 4857.95142048575, 4863.513648635108, 4869.780859861244, 4875.634327425528, 4881.731504767272, 4784.47370789206, 4806.149632391484, 4830.9275360870315, 4852.0, 4883.755812209446, 4656.604188644003, 4728.101660684459, 4903.828366007173, 4918.2868484068895, 4945.23348880924, 4640.930386044144, 4758.333833263415, 4788.592969597623, 4802.4957379476045, 4805.327254184347], "value": 3729.71440878774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.8206928955957, 713.3116542536451, 730.4302643937727, 761.8095476130967, 762.4891322813711, 12293.26240425574, 13066.0, 13427.597172084828, 13468.932655336723, 13699.589012329647, 13038.869611303884, 13240.205587664746, 13305.268210248432, 13307.334633268347, 13316.400761965711, 633.8478765096366, 758.2682711183693, 778.0740918307197, 778.346189201071, 780.4263866058443, 541.656048409261, 740.1377395334429, 779.123486078162, 784.7763387434583, 787.6573690444646, 827.6234313387424, 830.1449507007792, 830.5432012393189, 830.5598033042497, 830.6635812495949, 643.65886080377, 825.8678611422174, 826.5164878546058, 826.5164878546058, 827.2513375395276, 489.73309546297355, 565.9349174844905, 596.9761209551613, 601.2064075420446, 603.9063945088518, 13183.406746696422, 13210.471581136742, 13227.470901163942, 13233.735325293537, 13249.60251192456, 12063.336516491589, 12533.373331333489, 12777.936110319482, 12931.741365172738, 13264.336783160803, 12113.454894529767, 12140.696482587917, 12233.694157646041, 12243.0, 12442.751144977141, 4113.218488487208, 4152.875413737593, 4162.562930892243, 4163.91672166558, 4270.338097594878, 62651.0, 63278.683606581675, 63308.683456582425, 63910.0413493798, 64056.0, 10086.688730464992, 10200.591976320864, 10511.684649460376, 10631.255812093079, 10917.617883374203, 20036.39890803278, 20043.699344509845, 20066.498337541678, 20069.39791806248, 20070.698939515918, 6752.864942701217, 6822.249552549216, 6883.174019117738, 7039.859202815915, 7050.858982820418, 3562.5012498250267, 3572.1426857554, 3599.6220396857952, 3646.8176591170336, 3678.411454167374, 2941.7940744147704, 3013.8945136920543, 3053.2214285357536, 3053.908382748521, 3058.311879827021, 495.841330774156, 496.0277855403378, 503.4436947173394, 507.1049597460485, 513.3403576404377, 446.2948541304731, 494.5796073337634, 509.84194899580507, 512.106374376715, 542.1352942057412, 6638.502112341594, 6708.161479815023, 7159.427245820322, 7318.121825380988, 7402.111746590336, 508.92874997500377, 513.6070905757099, 515.5257163409672, 518.9247559103909, 529.1639210048191, 3443.3113377324635, 3493.7729047611824, 3568.411212149966, 3572.7499075065016, 3644.3804553226014, 100402.0, 101889.0, 102021.0, 105033.0, 105773.47113264384, 88275.0, 88344.0, 89467.55266223627, 90413.54793225991, 90734.0, 49888.75055624699, 57233.0, 77487.61256193682, 78279.2172078272, 78957.60521197472, 6604.537682362188, 6691.1636045494315, 6772.966135169293, 6851.143607049119, 6964.338387853146, 43588.46173073937, 44574.3313850299, 44944.55055449404, 45399.319010215535, 47037.76481117572, 37052.25895482129, 37513.249735005695, 47079.52920470751, 51829.740851297014, 53775.193372100235, 10260.897391026292, 10508.054275115277, 10523.894761052292, 10593.152547796311, 10605.25763196569, 11850.585229516926, 12139.150259481752, 12267.815982760087, 12370.876291236973, 12545.87454125447, 10820.350778953289, 11078.11375090007, 11239.66281011571, 11315.886841131483, 11407.714807129556, 11565.884341156481, 11588.246763960316, 11652.184347095623, 11678.06575473977, 12509.249445033327, 10597.25819192649, 11050.502727377127, 11538.59614913474, 12157.574484892986, 12243.0, 8237.546934918637, 8434.789130271547, 8442.113578074213, 8804.515751633466, 8979.865302020344, 8323.0, 8924.509151996443, 9023.954880225558, 9025.638974440948, 9093.318001149808], "value": 6379.323612017536, "unit": "score"}], "name": "dromaeo_css", "value": 6253.399234146656, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 115.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 131.0, 171.0, 124.0, 132.0, 130.0, 126.0, 174.0, 132.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 107.0, 77.0, 77.0, 77.0, 77.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 85.0, 86.0, 84.0, 107.0, 85.0, 84.0, 122.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 63.0, 64.0, 65.0, 65.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 91.0, 89.0, 83.0, 89.0, 82.0, 83.0, 92.0, 82.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 135.0, 140.0, 132.0, 130.0, 134.0, 133.0, 136.0, 173.0, 134.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 175.0, 173.0, 170.0, 170.0, 175.0, 174.0, 179.0, 176.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 72.0, 70.0, 67.0, 68.0, 67.0, 68.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1548.5999999999997, "alertThreshold": 2.0}]} 09:25:27 INFO - Return code: 0 09:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:27 INFO - # TBPL SUCCESS # 09:25:27 INFO - Running post-action listener: _resource_record_post_action 09:25:27 INFO - [mozharness: 2016-09-28 16:25:27.329001Z] Finished run-tests step (success) 09:25:27 INFO - Running post-run listener: _resource_record_post_run 09:25:27 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390844416; Read time: 8; Write time: 332780 09:25:27 INFO - TinderboxPrint: CPU usage
13.0% 09:25:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:25:27 INFO - TinderboxPrint: I/O write bytes / time
390,844,416 / 332,780 09:25:27 INFO - TinderboxPrint: CPU idle
8,350.0 (87.0%) 09:25:27 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 09:25:27 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99545088; Read time: 0; Write time: 97252 09:25:27 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291299328; Read time: 0; Write time: 235528 09:25:27 INFO - Running post-run listener: _upload_blobber_files 09:25:27 INFO - Blob upload gear active. 09:25:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:27 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 09:25:27 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:27 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:31 INFO - (blobuploader) - INFO - Done attempting. 09:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:32 INFO - (blobuploader) - INFO - Done attempting. 09:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:33 INFO - (blobuploader) - INFO - Done attempting. 09:25:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:33 INFO - Return code: 0 09:25:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6289c836f282b20d0a9548110164ca9ed248e6ff1fb9da01edc3d043b0a1b24c71b9f89be168e7ba48bcbf59e58ce1ba50d1af2f10fbb55c24061eccd0df9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c59e537ab93a80b7adb5f6701dee804d2a5c4cf2c47eddaca003e494cc2757271db80a9249b9342138717f624c2f18a6ada0359350c819b7541d1ca5a3c1f5ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d37aa4a9c94c085dec9446a3879e674c4026f65b12efe28541923db05bcfa3aba8d2f73763ce5bc3f2c31a2e4841d102dee7ba513d2dd60d5ee8e1c9da1bbf5"} 09:25:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:33 INFO - Contents: 09:25:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6289c836f282b20d0a9548110164ca9ed248e6ff1fb9da01edc3d043b0a1b24c71b9f89be168e7ba48bcbf59e58ce1ba50d1af2f10fbb55c24061eccd0df9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c59e537ab93a80b7adb5f6701dee804d2a5c4cf2c47eddaca003e494cc2757271db80a9249b9342138717f624c2f18a6ada0359350c819b7541d1ca5a3c1f5ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d37aa4a9c94c085dec9446a3879e674c4026f65b12efe28541923db05bcfa3aba8d2f73763ce5bc3f2c31a2e4841d102dee7ba513d2dd60d5ee8e1c9da1bbf5"} 09:25:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:33 INFO - Copying logs to upload dir... 09:25:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.550556 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-28 09:25:33.313077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:33.317134) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 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-Non-PGO/sha512/b6289c836f282b20d0a9548110164ca9ed248e6ff1fb9da01edc3d043b0a1b24c71b9f89be168e7ba48bcbf59e58ce1ba50d1af2f10fbb55c24061eccd0df9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c59e537ab93a80b7adb5f6701dee804d2a5c4cf2c47eddaca003e494cc2757271db80a9249b9342138717f624c2f18a6ada0359350c819b7541d1ca5a3c1f5ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d37aa4a9c94c085dec9446a3879e674c4026f65b12efe28541923db05bcfa3aba8d2f73763ce5bc3f2c31a2e4841d102dee7ba513d2dd60d5ee8e1c9da1bbf5"} build_url:https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/Qf29cYE-QHyM3JWx411pdg/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-Non-PGO/sha512/b6289c836f282b20d0a9548110164ca9ed248e6ff1fb9da01edc3d043b0a1b24c71b9f89be168e7ba48bcbf59e58ce1ba50d1af2f10fbb55c24061eccd0df9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c59e537ab93a80b7adb5f6701dee804d2a5c4cf2c47eddaca003e494cc2757271db80a9249b9342138717f624c2f18a6ada0359350c819b7541d1ca5a3c1f5ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d37aa4a9c94c085dec9446a3879e674c4026f65b12efe28541923db05bcfa3aba8d2f73763ce5bc3f2c31a2e4841d102dee7ba513d2dd60d5ee8e1c9da1bbf5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:33.343791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:33.344116) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475077703.868855-1186332715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:33.430697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 09:25:33.431346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 09:25:33.431695) ========= ========= Total master_lag: 2.93 =========