builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1474998881.13 results: success (0) buildid: 20160927101220 builduid: b343ad0e539c44bfbb74fe9e92756500 revision: f148d84038400a368315d1d0391ed0ea498ca676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.129132) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.129661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.130050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.145056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.145352) ========= 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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 10:54:41-- 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% 42.8M=0s 2016-09-27 10:54:41 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.246445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.247302) ========= 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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023416 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:41.299268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 10:54:41.300146) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f148d84038400a368315d1d0391ed0ea498ca676 --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 f148d84038400a368315d1d0391ed0ea498ca676 --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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 10:54:41,612 truncating revision to first 12 chars 2016-09-27 10:54:41,612 Setting DEBUG logging. 2016-09-27 10:54:41,612 attempt 1/10 2016-09-27 10:54:41,612 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f148d8403840?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 10:54:42,622 unpacking tar archive at: fx-team-f148d8403840/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385759 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 10:54:42.702555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:42.703271) ========= script_repo_revision: f148d84038400a368315d1d0391ed0ea498ca676 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:42.703953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:42.704634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 10:54:42.716124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-27 10:54:42.716456) ========= /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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:54:43 INFO - MultiFileLogger online at 20160927 10:54:43 in /builds/slave/test 10:54:43 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 10:54:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:54:43 INFO - {'append_to_log': False, 10:54:43 INFO - 'base_work_dir': '/builds/slave/test', 10:54:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:54:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:54:43 INFO - 'branch': 'Fx-Team-Non-PGO', 10:54:43 INFO - 'buildbot_json_path': 'buildprops.json', 10:54:43 INFO - 'config_files': ('talos/linux_config.py',), 10:54:43 INFO - 'default_actions': ('clobber', 10:54:43 INFO - 'read-buildbot-config', 10:54:43 INFO - 'download-and-extract', 10:54:43 INFO - 'populate-webroot', 10:54:43 INFO - 'create-virtualenv', 10:54:43 INFO - 'install', 10:54:43 INFO - 'run-tests'), 10:54:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:54:43 INFO - 'download_minidump_stackwalk': True, 10:54:43 INFO - 'download_symbols': 'ondemand', 10:54:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:54:43 INFO - 'tooltool.py': '/tools/tooltool.py', 10:54:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:54:43 INFO - '/tools/misc-python/virtualenv.py')}, 10:54:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:54:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:54:43 INFO - 'installer_path': 'installer.exe', 10:54:43 INFO - 'log_level': 'info', 10:54:43 INFO - 'log_name': 'talos', 10:54:43 INFO - 'log_to_console': True, 10:54:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:54:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:54:43 INFO - 'opt_config_files': (), 10:54:43 INFO - 'pip_index': False, 10:54:43 INFO - 'sps_profile': False, 10:54:43 INFO - 'sps_profile_interval': 0, 10:54:43 INFO - 'suite': 'dromaeojs', 10:54:43 INFO - 'system_bits': '32', 10:54:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:54:43 INFO - 'title': 'talos-linux64-ix-027', 10:54:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:54:43 INFO - 'use_talos_json': True, 10:54:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:54:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:54:43 INFO - 'work_dir': 'build'} 10:54:43 INFO - [mozharness: 2016-09-27 17:54:43.119724Z] Running clobber step. 10:54:43 INFO - Running pre-action listener: _resource_record_pre_action 10:54:43 INFO - Running main action method: clobber 10:54:43 INFO - rmtree: /builds/slave/test/build 10:54:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:54:43 INFO - Running post-action listener: _resource_record_post_action 10:54:43 INFO - [mozharness: 2016-09-27 17:54:43.591879Z] Finished clobber step (success) 10:54:43 INFO - [mozharness: 2016-09-27 17:54:43.591981Z] Running read-buildbot-config step. 10:54:43 INFO - Running pre-action listener: _resource_record_pre_action 10:54:43 INFO - Running main action method: read_buildbot_config 10:54:43 INFO - Using buildbot properties: 10:54:43 INFO - { 10:54:43 INFO - "project": "", 10:54:43 INFO - "product": "firefox", 10:54:43 INFO - "script_repo_revision": "production", 10:54:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:54:43 INFO - "repository": "", 10:54:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:54:43 INFO - "buildid": "20160927101220", 10:54:43 INFO - "pgo_build": "False", 10:54:43 INFO - "basedir": "/builds/slave/test", 10:54:43 INFO - "buildnumber": 1955, 10:54:43 INFO - "slavename": "talos-linux64-ix-027", 10:54:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:54:43 INFO - "platform": "ubuntu64_hw", 10:54:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:54:43 INFO - "branch": "fx-team", 10:54:43 INFO - "repo_path": "integration/fx-team", 10:54:43 INFO - "revision": "f148d84038400a368315d1d0391ed0ea498ca676", 10:54:43 INFO - "stage_platform": "linux64", 10:54:43 INFO - "builduid": "b343ad0e539c44bfbb74fe9e92756500", 10:54:43 INFO - "slavebuilddir": "test" 10:54:43 INFO - } 10:54:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:54:43 INFO - Running post-action listener: _resource_record_post_action 10:54:43 INFO - [mozharness: 2016-09-27 17:54:43.594403Z] Finished read-buildbot-config step (success) 10:54:43 INFO - [mozharness: 2016-09-27 17:54:43.594491Z] Running download-and-extract step. 10:54:43 INFO - Running pre-action listener: _resource_record_pre_action 10:54:43 INFO - Running main action method: download_and_extract 10:54:43 INFO - mkdir: /builds/slave/test/build/tests 10:54:43 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')]} 10:54:43 INFO - trying https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:54:43 INFO - Downloading https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/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 10:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/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 10:54:44 INFO - Downloaded 1361 bytes. 10:54:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:54:44 INFO - Using the following test package requirements: 10:54:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:54:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:54:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:54:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'jsshell-linux-x86_64.zip'], 10:54:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:54:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:54:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:54:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:54:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:54:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:54:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:54:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:54:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:54:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:54:44 INFO - Fetch https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:54:44 INFO - Expected file size: 20413434 10:54:49 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 10:54:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:54:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:54:49 INFO - Fetch https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:54:49 INFO - Expected file size: 20413434 10:54:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:54:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:54:54 INFO - Fetch https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:54:54 INFO - Expected file size: 14414062 10:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:55 INFO - trying https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:54:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/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 10:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/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 10:54:56 INFO - Downloaded 55734060 bytes. 10:54:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:54:56 INFO - mkdir: /builds/slave/test/properties 10:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:56 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:56 INFO - Contents: 10:54:56 INFO - build_url:https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:54:57 INFO - Running post-action listener: _resource_record_post_action 10:54:57 INFO - Running post-action listener: set_extra_try_arguments 10:54:57 INFO - [mozharness: 2016-09-27 17:54:57.133433Z] Finished download-and-extract step (success) 10:54:57 INFO - [mozharness: 2016-09-27 17:54:57.133657Z] Running populate-webroot step. 10:54:57 INFO - Running pre-action listener: _resource_record_pre_action 10:54:57 INFO - Running main action method: populate_webroot 10:54:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:57 INFO - '--tppagecycles', 10:54:57 INFO - '7'], 10:54:57 INFO - 'tests': ['tsvgm']}}, 10:54:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['damp', 'tps']}, 10:54:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'tests': ['damp', 'tps']}, 10:54:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['dromaeo_dom']}, 10:54:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['basic_compositor_video']}, 10:54:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:54:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['a11yr', 10:54:57 INFO - 'ts_paint', 10:54:57 INFO - 'tpaint', 10:54:57 INFO - 'sessionrestore', 10:54:57 INFO - 'sessionrestore_no_auto_restore', 10:54:57 INFO - 'tabpaint']}, 10:54:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['tsvgx', 10:54:57 INFO - 'tsvgr_opacity', 10:54:57 INFO - 'tart', 10:54:57 INFO - 'tscrollx', 10:54:57 INFO - 'cart']}, 10:54:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:57 INFO - 'tsvgr_opacity', 10:54:57 INFO - 'tart', 10:54:57 INFO - 'tscrollx', 10:54:57 INFO - 'cart']}, 10:54:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'talos_options': ['--disable-e10s'], 10:54:57 INFO - 'tests': ['tp5o']}, 10:54:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'tests': ['tp5o']}, 10:54:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'talos_options': ['--disable-e10s', 10:54:57 INFO - '--xperf_path', 10:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:57 INFO - 'tests': ['tp5n']}, 10:54:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:57 INFO - 'talos_options': ['--xperf_path', 10:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:57 INFO - 'tests': ['tp5n']}}, 10:54:57 INFO - 'talos.zip': {'path': '', 10:54:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:57 INFO - Running post-action listener: _resource_record_post_action 10:54:57 INFO - [mozharness: 2016-09-27 17:54:57.153090Z] Finished populate-webroot step (success) 10:54:57 INFO - [mozharness: 2016-09-27 17:54:57.153178Z] Running create-virtualenv step. 10:54:57 INFO - Running pre-action listener: _resource_record_pre_action 10:54:57 INFO - Running main action method: create_virtualenv 10:54:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:57 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 10:54:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:57 INFO - Using real prefix '/usr' 10:54:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:59 INFO - Installing pip.................done. 10:54:59 INFO - Return code: 0 10:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:54:59 INFO - Reading from file tmpfile_stdout 10:54:59 INFO - Output received: 10:54:59 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) 10:54:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54: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')]} 10:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:59 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:54:59 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 10:54:59 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 10:54:59 INFO - Using env: {'DISPLAY': ':0', 10:54:59 INFO - 'HOME': '/home/cltbld', 10:54:59 INFO - 'LANG': 'en_US.UTF-8', 10:54:59 INFO - 'LANGUAGE': 'en_US:en', 10:54:59 INFO - 'LOGNAME': 'cltbld', 10:54:59 INFO - 'MAIL': '/var/mail/cltbld', 10:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:59 INFO - 'MOZ_NO_REMOTE': '1', 10:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:59 INFO - 'NO_EM_RESTART': '1', 10:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:59 INFO - 'PWD': '/builds/slave/test', 10:54:59 INFO - 'SHELL': '/bin/bash', 10:54:59 INFO - 'SHLVL': '1', 10:54:59 INFO - 'TERM': 'linux', 10:54:59 INFO - 'TMOUT': '86400', 10:54:59 INFO - 'USER': 'cltbld', 10:54:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:59 INFO - '_': '/tools/buildbot/bin/python'} 10:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:00 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 10:55:00 INFO - Cleaning up... 10:55:00 INFO - Return code: 0 10:55:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:00 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:00 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 10:55:00 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 10:55:00 INFO - Using env: {'DISPLAY': ':0', 10:55:00 INFO - 'HOME': '/home/cltbld', 10:55:00 INFO - 'LANG': 'en_US.UTF-8', 10:55:00 INFO - 'LANGUAGE': 'en_US:en', 10:55:00 INFO - 'LOGNAME': 'cltbld', 10:55:00 INFO - 'MAIL': '/var/mail/cltbld', 10:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:00 INFO - 'MOZ_NO_REMOTE': '1', 10:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:00 INFO - 'NO_EM_RESTART': '1', 10:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:00 INFO - 'PWD': '/builds/slave/test', 10:55:00 INFO - 'SHELL': '/bin/bash', 10:55:00 INFO - 'SHLVL': '1', 10:55:00 INFO - 'TERM': 'linux', 10:55:00 INFO - 'TMOUT': '86400', 10:55:00 INFO - 'USER': 'cltbld', 10:55:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:00 INFO - '_': '/tools/buildbot/bin/python'} 10:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:00 INFO - Downloading/unpacking psutil>=3.1.1 10:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:02 INFO - Installing collected packages: psutil 10:55:02 INFO - Running setup.py install for psutil 10:55:02 INFO - building 'psutil._psutil_linux' extension 10:55:02 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 10:55:02 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 10:55:02 INFO - building 'psutil._psutil_posix' extension 10:55:02 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 10:55:02 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 10:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:02 INFO - Successfully installed psutil 10:55:02 INFO - Cleaning up... 10:55:02 INFO - Return code: 0 10:55:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:02 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:02 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 10:55:02 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 10:55:02 INFO - Using env: {'DISPLAY': ':0', 10:55:02 INFO - 'HOME': '/home/cltbld', 10:55:02 INFO - 'LANG': 'en_US.UTF-8', 10:55:02 INFO - 'LANGUAGE': 'en_US:en', 10:55:02 INFO - 'LOGNAME': 'cltbld', 10:55:02 INFO - 'MAIL': '/var/mail/cltbld', 10:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:02 INFO - 'MOZ_NO_REMOTE': '1', 10:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:02 INFO - 'NO_EM_RESTART': '1', 10:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:02 INFO - 'PWD': '/builds/slave/test', 10:55:02 INFO - 'SHELL': '/bin/bash', 10:55:02 INFO - 'SHLVL': '1', 10:55:02 INFO - 'TERM': 'linux', 10:55:02 INFO - 'TMOUT': '86400', 10:55:02 INFO - 'USER': 'cltbld', 10:55:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:02 INFO - '_': '/tools/buildbot/bin/python'} 10:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:55:03 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 10:55:03 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 10:55:03 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 10:55:03 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 10:55:03 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 10:55:03 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 10:55:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:55:05 INFO - Installing collected packages: mozsystemmonitor 10:55:05 INFO - Running setup.py install for mozsystemmonitor 10:55:05 INFO - Successfully installed mozsystemmonitor 10:55:05 INFO - Cleaning up... 10:55:05 INFO - Return code: 0 10:55:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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', '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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:55: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 jsonschema==2.5.1 10:55:05 INFO - Using env: {'DISPLAY': ':0', 10:55:05 INFO - 'HOME': '/home/cltbld', 10:55:05 INFO - 'LANG': 'en_US.UTF-8', 10:55:05 INFO - 'LANGUAGE': 'en_US:en', 10:55:05 INFO - 'LOGNAME': 'cltbld', 10:55:05 INFO - 'MAIL': '/var/mail/cltbld', 10:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:05 INFO - 'MOZ_NO_REMOTE': '1', 10:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:05 INFO - 'NO_EM_RESTART': '1', 10:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:05 INFO - 'PWD': '/builds/slave/test', 10:55:05 INFO - 'SHELL': '/bin/bash', 10:55:05 INFO - 'SHLVL': '1', 10:55:05 INFO - 'TERM': 'linux', 10:55:05 INFO - 'TMOUT': '86400', 10:55:05 INFO - 'USER': 'cltbld', 10:55:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:05 INFO - '_': '/tools/buildbot/bin/python'} 10:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:55:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:55:07 INFO - warning: no files found matching '*.txt' 10:55:07 INFO - no previously-included directories found matching 'build' 10:55:07 INFO - no previously-included directories found matching 'dist' 10:55:07 INFO - no previously-included directories found matching '.git*' 10:55:07 INFO - Installing collected packages: jsonschema, functools32 10:55:07 INFO - Running setup.py install for functools32 10:55:07 INFO - warning: no files found matching '*.txt' 10:55:07 INFO - no previously-included directories found matching 'build' 10:55:07 INFO - no previously-included directories found matching 'dist' 10:55:07 INFO - no previously-included directories found matching '.git*' 10:55:07 INFO - Successfully installed jsonschema functools32 10:55:07 INFO - Cleaning up... 10:55:07 INFO - Return code: 0 10:55:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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', '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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:55: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 functools32==3.2.3-2 10:55:07 INFO - Using env: {'DISPLAY': ':0', 10:55:07 INFO - 'HOME': '/home/cltbld', 10:55:07 INFO - 'LANG': 'en_US.UTF-8', 10:55:07 INFO - 'LANGUAGE': 'en_US:en', 10:55:07 INFO - 'LOGNAME': 'cltbld', 10:55:07 INFO - 'MAIL': '/var/mail/cltbld', 10:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:07 INFO - 'MOZ_NO_REMOTE': '1', 10:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:07 INFO - 'NO_EM_RESTART': '1', 10:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:07 INFO - 'PWD': '/builds/slave/test', 10:55:07 INFO - 'SHELL': '/bin/bash', 10:55:07 INFO - 'SHLVL': '1', 10:55:07 INFO - 'TERM': 'linux', 10:55:07 INFO - 'TMOUT': '86400', 10:55:07 INFO - 'USER': 'cltbld', 10:55:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:07 INFO - '_': '/tools/buildbot/bin/python'} 10:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:55:08 INFO - Cleaning up... 10:55:08 INFO - Return code: 0 10:55:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55:08 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')]} 10:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:08 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')]} 10:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:08 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:08 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 10:55:08 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 10:55:08 INFO - Using env: {'DISPLAY': ':0', 10:55:08 INFO - 'HOME': '/home/cltbld', 10:55:08 INFO - 'LANG': 'en_US.UTF-8', 10:55:08 INFO - 'LANGUAGE': 'en_US:en', 10:55:08 INFO - 'LOGNAME': 'cltbld', 10:55:08 INFO - 'MAIL': '/var/mail/cltbld', 10:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:08 INFO - 'MOZ_NO_REMOTE': '1', 10:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:08 INFO - 'NO_EM_RESTART': '1', 10:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:08 INFO - 'PWD': '/builds/slave/test', 10:55:08 INFO - 'SHELL': '/bin/bash', 10:55:08 INFO - 'SHLVL': '1', 10:55:08 INFO - 'TERM': 'linux', 10:55:08 INFO - 'TMOUT': '86400', 10:55:08 INFO - 'USER': 'cltbld', 10:55:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:08 INFO - '_': '/tools/buildbot/bin/python'} 10:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:08 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 10:55:08 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 10:55:08 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 10:55:08 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 10:55:08 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 10:55:08 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 10:55:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:10 INFO - Downloading docopt-0.6.1.tar.gz 10:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:10 INFO - Running setup.py install for blobuploader 10:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:55:11 INFO - Running setup.py install for requests 10:55:11 INFO - Running setup.py install for docopt 10:55:11 INFO - Successfully installed blobuploader requests docopt 10:55:11 INFO - Cleaning up... 10:55:11 INFO - Return code: 0 10:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:11 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:11 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 10:55:11 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 10:55:11 INFO - Using env: {'DISPLAY': ':0', 10:55:11 INFO - 'HOME': '/home/cltbld', 10:55:11 INFO - 'LANG': 'en_US.UTF-8', 10:55:11 INFO - 'LANGUAGE': 'en_US:en', 10:55:11 INFO - 'LOGNAME': 'cltbld', 10:55:11 INFO - 'MAIL': '/var/mail/cltbld', 10:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:11 INFO - 'MOZ_NO_REMOTE': '1', 10:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:11 INFO - 'NO_EM_RESTART': '1', 10:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:11 INFO - 'PWD': '/builds/slave/test', 10:55:11 INFO - 'SHELL': '/bin/bash', 10:55:11 INFO - 'SHLVL': '1', 10:55:11 INFO - 'TERM': 'linux', 10:55:11 INFO - 'TMOUT': '86400', 10:55:11 INFO - 'USER': 'cltbld', 10:55:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:11 INFO - '_': '/tools/buildbot/bin/python'} 10:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:11 INFO - Running setup.py (path:/tmp/pip-JQq32Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:11 INFO - Running setup.py (path:/tmp/pip-nvrfuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:11 INFO - Running setup.py (path:/tmp/pip-8vAl7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:11 INFO - Running setup.py (path:/tmp/pip-ViwEeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:12 INFO - Running setup.py (path:/tmp/pip-Urd0cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:12 INFO - Running setup.py (path:/tmp/pip-H0PTKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:12 INFO - Running setup.py (path:/tmp/pip-Y8RfIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:12 INFO - Running setup.py (path:/tmp/pip-Zn5W3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:12 INFO - Running setup.py (path:/tmp/pip-YoRFbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:12 INFO - Running setup.py (path:/tmp/pip-8MqExv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:12 INFO - Running setup.py (path:/tmp/pip-pbpUcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:12 INFO - Running setup.py (path:/tmp/pip-YULuUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:12 INFO - Running setup.py (path:/tmp/pip-yZClZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:12 INFO - Running setup.py (path:/tmp/pip-UtvpTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:12 INFO - Running setup.py (path:/tmp/pip-IwR9HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:12 INFO - Running setup.py (path:/tmp/pip-0RYaY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:12 INFO - Running setup.py (path:/tmp/pip-dUfEd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:12 INFO - Running setup.py install for manifestparser 10:55:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for mozcrash 10:55:13 INFO - Running setup.py install for mozdebug 10:55:13 INFO - Running setup.py install for mozdevice 10:55:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for mozfile 10:55:13 INFO - Running setup.py install for mozhttpd 10:55:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for mozinfo 10:55:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for mozInstall 10:55:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for mozleak 10:55:13 INFO - Running setup.py install for mozlog 10:55:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:55:13 INFO - Running setup.py install for moznetwork 10:55:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Running setup.py install for mozprocess 10:55:14 INFO - Running setup.py install for mozprofile 10:55:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Running setup.py install for mozrunner 10:55:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Running setup.py install for mozscreenshot 10:55:14 INFO - Running setup.py install for moztest 10:55:14 INFO - Running setup.py install for mozversion 10:55:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:55:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:14 INFO - Cleaning up... 10:55:14 INFO - Return code: 0 10:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:14 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')]} 10:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:14 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')]} 10:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:14 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:14 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 10:55:14 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 10:55:14 INFO - Using env: {'DISPLAY': ':0', 10:55:14 INFO - 'HOME': '/home/cltbld', 10:55:14 INFO - 'LANG': 'en_US.UTF-8', 10:55:14 INFO - 'LANGUAGE': 'en_US:en', 10:55:14 INFO - 'LOGNAME': 'cltbld', 10:55:14 INFO - 'MAIL': '/var/mail/cltbld', 10:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:14 INFO - 'MOZ_NO_REMOTE': '1', 10:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:14 INFO - 'NO_EM_RESTART': '1', 10:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:14 INFO - 'PWD': '/builds/slave/test', 10:55:14 INFO - 'SHELL': '/bin/bash', 10:55:14 INFO - 'SHLVL': '1', 10:55:14 INFO - 'TERM': 'linux', 10:55:14 INFO - 'TMOUT': '86400', 10:55:14 INFO - 'USER': 'cltbld', 10:55:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:14 INFO - '_': '/tools/buildbot/bin/python'} 10:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:14 INFO - Running setup.py (path:/tmp/pip-aPIxmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:15 INFO - Running setup.py (path:/tmp/pip-YNK0Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:15 INFO - Running setup.py (path:/tmp/pip-eVT1yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:15 INFO - Running setup.py (path:/tmp/pip-vnjzYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:15 INFO - Running setup.py (path:/tmp/pip-GKj3Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:15 INFO - Running setup.py (path:/tmp/pip-UAXtPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:15 INFO - Running setup.py (path:/tmp/pip-V_HR9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:15 INFO - Running setup.py (path:/tmp/pip-r8EeWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:15 INFO - Running setup.py (path:/tmp/pip-uvJsSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:15 INFO - Running setup.py (path:/tmp/pip-L6OhJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:15 INFO - Running setup.py (path:/tmp/pip-noLmoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:15 INFO - Running setup.py (path:/tmp/pip-Nrwmtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:15 INFO - Running setup.py (path:/tmp/pip-ukFRV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:15 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)) 10:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:15 INFO - Running setup.py (path:/tmp/pip-aw57WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:16 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)) 10:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:16 INFO - Running setup.py (path:/tmp/pip-vvcIkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:16 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)) 10:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:16 INFO - Running setup.py (path:/tmp/pip-r5cmug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:16 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)) 10:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:16 INFO - Running setup.py (path:/tmp/pip-3TtSIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:16 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)) 10:55:16 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)) 10:55:16 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)) 10:55:16 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)) 10:55:16 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)) 10:55:16 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)) 10:55:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:16 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 10:55:16 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 10:55:16 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 10:55:16 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 10:55:16 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 10:55:16 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 10:55:18 INFO - Downloading blessings-1.6.tar.gz 10:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:18 INFO - Installing collected packages: blessings 10:55:18 INFO - Running setup.py install for blessings 10:55:18 INFO - Successfully installed blessings 10:55:18 INFO - Cleaning up... 10:55:18 INFO - Return code: 0 10:55:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:18 INFO - Reading from file tmpfile_stdout 10:55:18 INFO - Current package versions: 10:55:18 INFO - argparse == 1.2.1 10:55:18 INFO - blessings == 1.6 10:55:18 INFO - blobuploader == 1.2.4 10:55:18 INFO - docopt == 0.6.1 10:55:18 INFO - functools32 == 3.2.3-2 10:55:18 INFO - jsonschema == 2.5.1 10:55:18 INFO - manifestparser == 1.1 10:55:18 INFO - mozInstall == 1.12 10:55:18 INFO - mozcrash == 0.17 10:55:18 INFO - mozdebug == 0.1 10:55:18 INFO - mozdevice == 0.48 10:55:18 INFO - mozfile == 1.2 10:55:18 INFO - mozhttpd == 0.7 10:55:18 INFO - mozinfo == 0.9 10:55:18 INFO - mozleak == 0.1 10:55:18 INFO - mozlog == 3.4 10:55:18 INFO - moznetwork == 0.27 10:55:18 INFO - mozprocess == 0.23 10:55:18 INFO - mozprofile == 0.28 10:55:18 INFO - mozrunner == 6.12 10:55:18 INFO - mozscreenshot == 0.1 10:55:18 INFO - mozsystemmonitor == 0.3 10:55:18 INFO - moztest == 0.7 10:55:18 INFO - mozversion == 1.4 10:55:18 INFO - psutil == 3.1.1 10:55:18 INFO - requests == 1.2.3 10:55:18 INFO - wsgiref == 0.1.2 10:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:18 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')]} 10:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:18 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')]} 10:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:18 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:18 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 10:55:18 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 10:55:18 INFO - Using env: {'DISPLAY': ':0', 10:55:18 INFO - 'HOME': '/home/cltbld', 10:55:18 INFO - 'LANG': 'en_US.UTF-8', 10:55:18 INFO - 'LANGUAGE': 'en_US:en', 10:55:18 INFO - 'LOGNAME': 'cltbld', 10:55:18 INFO - 'MAIL': '/var/mail/cltbld', 10:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:18 INFO - 'MOZ_NO_REMOTE': '1', 10:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:18 INFO - 'NO_EM_RESTART': '1', 10:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:18 INFO - 'PWD': '/builds/slave/test', 10:55:18 INFO - 'SHELL': '/bin/bash', 10:55:18 INFO - 'SHLVL': '1', 10:55:18 INFO - 'TERM': 'linux', 10:55:18 INFO - 'TMOUT': '86400', 10:55:18 INFO - 'USER': 'cltbld', 10:55:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:18 INFO - '_': '/tools/buildbot/bin/python'} 10:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 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)) 10:55:18 INFO - Cleaning up... 10:55:18 INFO - Return code: 0 10:55:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:55:18 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')]} 10:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:18 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')]} 10:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:18 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 0x7f7e1fdfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, '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': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', '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 10:55:18 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 10:55:18 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 10:55:18 INFO - Using env: {'DISPLAY': ':0', 10:55:18 INFO - 'HOME': '/home/cltbld', 10:55:18 INFO - 'LANG': 'en_US.UTF-8', 10:55:18 INFO - 'LANGUAGE': 'en_US:en', 10:55:18 INFO - 'LOGNAME': 'cltbld', 10:55:18 INFO - 'MAIL': '/var/mail/cltbld', 10:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:18 INFO - 'MOZ_NO_REMOTE': '1', 10:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:18 INFO - 'NO_EM_RESTART': '1', 10:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:18 INFO - 'PWD': '/builds/slave/test', 10:55:18 INFO - 'SHELL': '/bin/bash', 10:55:18 INFO - 'SHLVL': '1', 10:55:18 INFO - 'TERM': 'linux', 10:55:18 INFO - 'TMOUT': '86400', 10:55:18 INFO - 'USER': 'cltbld', 10:55:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:18 INFO - '_': '/tools/buildbot/bin/python'} 10:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:55:19 INFO - Cleaning up... 10:55:19 INFO - Return code: 0 10:55:19 INFO - Running post-action listener: _resource_record_post_action 10:55:19 INFO - Running post-action listener: _start_resource_monitoring 10:55:19 INFO - Starting resource monitoring. 10:55:19 INFO - [mozharness: 2016-09-27 17:55:19.073121Z] Finished create-virtualenv step (success) 10:55:19 INFO - [mozharness: 2016-09-27 17:55:19.073621Z] Running install step. 10:55:19 INFO - Running pre-action listener: _resource_record_pre_action 10:55:19 INFO - Running main action method: install 10:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:19 INFO - Reading from file tmpfile_stdout 10:55:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:55:19 INFO - Reading from file tmpfile_stdout 10:55:19 INFO - Output received: 10:55:19 INFO - Usage: mozinstall [options] installer 10:55:19 INFO - Options: 10:55:19 INFO - -h, --help show this help message and exit 10:55:19 INFO - -d DEST, --destination=DEST 10:55:19 INFO - Directory to install application into. [default: 10:55:19 INFO - "/builds/slave/test"] 10:55:19 INFO - --app=APP Application being installed. [default: firefox] 10:55:19 INFO - mkdir: /builds/slave/test/build/application 10:55:19 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'] 10:55:19 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 10:55:35 INFO - Reading from file tmpfile_stdout 10:55:35 INFO - Output received: 10:55:35 INFO - /builds/slave/test/build/application/firefox/firefox 10:55:35 INFO - Running post-action listener: _resource_record_post_action 10:55:35 INFO - [mozharness: 2016-09-27 17:55:35.457961Z] Finished install step (success) 10:55:35 INFO - [mozharness: 2016-09-27 17:55:35.458205Z] Running run-tests step. 10:55:35 INFO - Running pre-action listener: _resource_record_pre_action 10:55:35 INFO - Running main action method: run_tests 10:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:35 INFO - Python 2.7.3 10:55:35 INFO - Return code: 0 10:55:35 INFO - grabbing minidump binary from tooltool 10:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:35 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 0x245af60>, '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 0x245bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:35 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 10:55:35 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 10:55:35 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 10:55:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:35 INFO - Return code: 0 10:55:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:55:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:55:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:35 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/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:55:35 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/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 10:55:35 INFO - Using env: {'DISPLAY': ':0', 10:55:35 INFO - 'HOME': '/home/cltbld', 10:55:35 INFO - 'LANG': 'en_US.UTF-8', 10:55:35 INFO - 'LANGUAGE': 'en_US:en', 10:55:35 INFO - 'LOGNAME': 'cltbld', 10:55:35 INFO - 'MAIL': '/var/mail/cltbld', 10:55:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:35 INFO - 'MOZ_NO_REMOTE': '1', 10:55:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:35 INFO - 'NO_EM_RESTART': '1', 10:55:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:35 INFO - 'PWD': '/builds/slave/test', 10:55:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:35 INFO - 'SHELL': '/bin/bash', 10:55:35 INFO - 'SHLVL': '1', 10:55:35 INFO - 'TERM': 'linux', 10:55:35 INFO - 'TMOUT': '86400', 10:55:35 INFO - 'USER': 'cltbld', 10:55:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090', 10:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:35 INFO - '_': '/tools/buildbot/bin/python'} 10:55:35 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/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:55:35 INFO - mozversion application_buildid: 20160927101220 10:55:35 INFO - mozversion application_changeset: f148d84038400a368315d1d0391ed0ea498ca676 10:55:35 INFO - mozversion application_display_name: Nightly 10:55:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:35 INFO - mozversion application_name: Firefox 10:55:35 INFO - mozversion application_remotingname: firefox 10:55:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:55:35 INFO - mozversion application_vendor: Mozilla 10:55:35 INFO - mozversion application_version: 52.0a1 10:55:35 INFO - mozversion platform_buildid: 20160927101220 10:55:35 INFO - mozversion platform_changeset: f148d84038400a368315d1d0391ed0ea498ca676 10:55:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:55:35 INFO - mozversion platform_version: 52.0a1 10:55:35 INFO - using testdate: 1474998935 10:55:35 INFO - actual date: 1474998935 10:55:35 INFO - starting webserver on 'localhost:48970' 10:55:35 INFO - SUITE-START | Running 2 tests 10:55:35 INFO - TEST-START | dromaeo_css 10:55:35 INFO - operating with platform_type : linux_ 10:55:35 INFO - Initialising browser for dromaeo_css test... 10:55:35 INFO - TEST-INFO | started process 24029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOXQLe/profile http://localhost:48970/getInfo.html) 10:55:40 INFO - PROCESS | 24029 | __metrics Screen width/height:1600/1200 10:55:40 INFO - PROCESS | 24029 | colorDepth:24 10:55:40 INFO - PROCESS | 24029 | Browser inner width/height: 1024/697 10:55:40 INFO - PROCESS | 24029 | __metrics 10:55:40 INFO - PROCESS | 24029 | 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" 10:55:40 INFO - PROCESS | 24029 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:55:41 INFO - TEST-INFO | 24029: exit 0 10:55:41 INFO - Browser initialized. 10:55:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:41 INFO - TEST-INFO | started process 24113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOXQLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:54 INFO - PROCESS | 24113 | RSS: Main: 175013888 10:55:54 INFO - PROCESS | 24113 | 10:56:46 INFO - PROCESS | 24113 | 1474999006079 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] 10:58:58 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48970/tests/dromaeo/cssquery-ext.html) 10:58:59 INFO - PROCESS | 24113 | RSS: Main: 292450304 10:58:59 INFO - PROCESS | 24113 | 11:02:02 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-ext.html (next: http://localhost:48970/tests/dromaeo/cssquery-jquery.html) 11:02:03 INFO - PROCESS | 24113 | RSS: Main: 270659584 11:02:03 INFO - PROCESS | 24113 | 11:05:05 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48970/tests/dromaeo/cssquery-mootools.html) 11:05:06 INFO - PROCESS | 24113 | RSS: Main: 219140096 11:05:06 INFO - PROCESS | 24113 | 11:08:08 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48970/tests/dromaeo/cssquery-prototype.html) 11:08:08 INFO - PROCESS | 24113 | RSS: Main: 218812416 11:08:08 INFO - PROCESS | 24113 | 11:11:11 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48970/tests/dromaeo/cssquery-yui.html) 11:11:12 INFO - PROCESS | 24113 | RSS: Main: 220798976 11:11:12 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | Cycle 1(1): loaded http://localhost:48970/tests/dromaeo/cssquery-yui.html (next: http://localhost:48970/tests/dromaeo/cssquery-dojo.html) 11:14:15 INFO - PROCESS | 24113 | RSS: Main: 297852928 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | __start_tp_report 11:14:15 INFO - PROCESS | 24113 | _x_x_mozilla_page_load 11:14:15 INFO - PROCESS | 24113 | _x_x_mozilla_page_load_details 11:14:15 INFO - PROCESS | 24113 | |i|pagename|runs| 11:14:15 INFO - PROCESS | 24113 | |0;dojo.html;2604.244769016985;2620.0960668569337;2655.402534429753;2662.8934842606286;2677.7590016898475;4586.633069354452;4675.4155730533685;4743.4782173960875;4827.58965487934;4900.558949694527;4707.78814953327;4787.856364309067;4818.51814818518;4840.878978025542;4864.027194561084;4317.395564620955;4339.175556644243;4369.672274579403;4396.450443694538;4410.62509686677;4385.21066208084;4478.484974227957;4484.955150448486;4494.573015563533;4501.482329532097;4416.823327066913;4451.732896026233;4468.463784345883;4493.415855938707;4503.707259028169;4296.978515107405;4321.373400856858;4336.392904993303;4346.782660866944;4374.4531933508315;4322.762248076355;4331.068820203672;4339.06710057336;4429.15845989261;4433.069055498349;4783.760811959388;4796.8560943171415;4847.684900481493;4849.515048495157;4891.951080489185;4902.166631672589;4951.084049450863;5007.24891266313;5138.948610513922;5147.6911385317;5081.237814327844;5116.923246151311;5118.718470484122;5119.206522988943;5177.792888284464;4738.549837765407;4765.571098601143;4774.594159496412;4775.450823155312;4809.735464549413;5064.544191022752;5122.385313762373;5170.482951704799;5259.47405259471;5361.035013697572;4997.475265097185;5017.799288028511;5017.89964200714;5063.721495317793;5084.593232541388;5106.183010718267;5111.514406131411;5113.437521872591;5114.207297868837;5179.870503237374;4946.183879659888;5021.59827213822;5041.647084704109;5046.1673823818655;5046.470120637354;5036.370453693288;5046.495350464924;5055.115354812967;5057.241413787961;5109.693418394908;4353.804078816461;4362.1493808707;4398.846040388571;4408.911821763547;4415.249407600716;3791.1469919267943;3792.229395223549;3814.2371525694416;3823.235352929425;3840.4047372657283;4199.139176468817;4244.766537840448;4424.070945101565;4427.424434823452;4429.55704429561;5105.770240339194;5159.767810448464;5159.896802064013;5168.948310516922;5220.399654039834;4339.7396156230725;4377.759223242752;4382.737035777864;4382.780860956939;4434.778261086933;4473.194824931544;4618.930716039262;4620.168369693488;4622.168009758208;4677.4854765975715;4680.063987202573;4731.597814185695;4810.39870016248;4820.39745031871;4840.443349014768;5203.115470370122;5203.505666961632;5219.243209734491;5223.320968274252;5249.973750131225;4791.257355109963;4828.348172996601;4832.468428472795;4833.903321933612;4893.363862697826;4936.901261974668;5003.199488081889;5011.398632164163;5064.772085256099;5114;5166.844994650167;5169.767360468863;5172.379314482136;5172.767225474938;5223.5559977402345;5035.395752509722;5040.067587496325;5047.570956468741;5047.64666473358;5112.309838171799;4870.2938073979785;4937.97531012357;4939.061578300111;4979.651424400257;5108.846734597968;4922.335484709519;4945.876353091202;4949.876253093701;5003.2745251938995;5012.674176178537;4854.393200849894;5005.924911126263;5053;5053.0399224147295;5120.871978200575;4788.521147885183;4854.878628034327;4867.878303042452;4896.461389247109;4903.28902309156 11:14:15 INFO - PROCESS | 24113 | |1;ext.html;522.3783697400091;546.9480399362059;568.2640979930989;568.4940403041293;572.2732130194652;25253.368665783364;37360.81319593402;38804;38823.611763882356;43640.781796090974;39456.80271598645;39785.403218951666;39842.20315593686;39941;39947.40078898812;7144.85710285794;7685.116211635677;7834.647440865147;7835.569043702622;7841.882371764428;7139.071920650308;9738.561764720605;9982.800343993116;9990.90009099907;10352.741181470448;10166.898331016706;10218.795624087514;10222.744431389237;10223;10234.488275586227;10041.447720375376;10109.696709098738;10121.544530496109;10123.392596444164;10128.392296462162;9594.66418675343;9673.37123086997;9675.322727409084;9676.854847177297;9680.806383872354;37274;37593.060173495884;37601;37837.24325513502;37870.24259514822;2623.2392606144194;2684.865756712157;2733.248356701903;2911.898083567065;3050.527168288919;28470.430591388056;28656.268746250626;28734;28818.42363152746;29903.700962990308;3462.5844898612327;3484.686378225972;3553.3248682750195;3591.5331006968927;3602.4056030754896;250134.74932625404;250321;250704;251775;253247;30874.69125308718;32147.839260803546;51241;51627.74186129045;51680.74159629178;33566.664333356355;33670.15824604405;33696.15759606029;33718.662813372044;33851.153721156676;11907.166498345032;11978.101642376856;12023.879761202452;12026.218295810744;12028.218165819193;8076.8788468173025;8244.876326855101;9289.907100928904;9865.802683946424;9940.304178707565;7557.168711441737;7678.96160519205;7768.961155194188;7771.494852834548;7791.259830316111;3005.218643152796;3041.8935337263533;3057.4955132402906;3061.341811510536;3130.076627394924;881.9514926678966;894.3069121430943;909.9272058235325;952.0622187145656;973.9220862330997;26993.730062699513;27380.863095684395;27602.723972760417;27900.860495697798;27983.580246296322;936.3539157980971;944.7096260938825;957.9377340472847;959.0265880131672;1029.8764148302103;13757.17456952586;14897.851021489647;15133;15137.924310378598;15181.468648597245;389342;391248;391352;391393;391785;31462.213444664067;31647.525287120712;31743.52384714231;31768.523472147936;31777.682223177933;950.9634498396642;975.3465178330536;992.7418871093423;1152.3546813784308;1181.787278289916;27149.59275610828;28478.857605712667;29089.563656545593;29207.561886572144;29587.556186656788;41026.79486602548;45059.54940450554;46878.29682554696;46932.76533617447;52526.212106817664;346023;350680;351070;351946;352053;24203.63694544548;24779.87610061938;24899.37751556153;26270.474590508464;38173.4273985896;40461;40865.38701919533;40866.1826763469;41659.583404166784;41769.79115104527;35030;35044;35100.473492897116;35196;35235.29529409449;33521;34717.65282347144;34798.652013480554;34952;35046.82476587601;34780.13049673779;34856.47715284323;34976.30047399089;35306.11734706653;36158.457623135146;29849.850750746107;31697.366052678357;31853.20366990844;32322.515162273055;32496;23870;24233.63649545223;24716.50566988686;25173.496530069664;25551.872240638677 11:14:15 INFO - PROCESS | 24113 | |2;jquery.html;330.4349562248555;366.5711117991949;368.1679404545728;370.1080396245049;393.71455694621403;11649.534018639255;12630.431630576635;14238.359273832677;16478.505644830646;17064.744028839577;15613.68772624547;15706.764398534031;16031.759523607156;16349.100799456055;16386.344546218166;4812.0857037163005;4944.9258261126115;4988;5008.799648014094;5055.9241611375855;3623.148560088377;3822.10180607557;5023.171176755831;5035.420926593452;5082.771275292602;3799.924001519968;3845.365514690073;3850.711196660248;3943.507061617298;5852.882942341172;5907.852303692421;5924.377940316291;5927.673977931212;5928.64428134309;5928.88142237155;5004.874878128039;5142.717150556718;5161.019406312788;5165.173572228426;5216.660917040418;19812.90093549523;20102.69845952312;20164.69752953707;20614.484637884023;20804.375868723964;1932.2657390191778;2065.0913598016823;2228.9554208915893;2376.3940195250275;2474.616434452663;8580.699675511327;11412;13231.139975901535;13738.450461981509;13938.37277322523;1627.3897288516807;1760.7622970899022;1788.3383148235107;1867.813218678135;1868.0566314011473;59585.702071489366;61108.694456527875;63415;66501.66749166271;71552.64223678848;9549.713508594754;9570.176797844653;9598.616055357847;9769.316147869724;9983.306176714663;12753.872461275269;12782.68043298925;12792.296423696785;12857.935710321388;12881.871181288254;6526.738930442824;6684.431823294977;6747.426468750211;6764.594124352555;6783.457323414115;6116.207951070365;6174.783882564088;6198.690065496708;6313.526485513605;6317.273513545909;4029.516458024997;4031.314676505001;4088.509378874554;4097.282975479279;4348.065165989327;1599.7680336351164;1672.8243534428952;1724.90513021785;1725.6721222967597;1727.9136043197789;738.6085374751391;778.9026371703537;780.980475488106;816.2368185746346;848.8981322241247;15596.220188990732;16496.917515412348;16672.166391680366;17389;17400;751.3388218367911;753.1226121568421;766.3715753082419;801.0267524957205;847.7922908887363;8809;9088.182063614306;9320.906790932004;9331.953340233254;9339.719808405758;362350;364242;365614;367478;367593;73590;74275;74859.62570187115;77356;77588.61205694049;814.535714642648;839.8698201778734;841.2134654098315;842.7724514381083;843.700486327345;13961.860381396462;14177.574672759834;14562.490312839;15115.697686046438;15159.621009474851;33152.50271245885;34881;34895.47656785201;35259.82370088133;35477.46783798194;44999.100018000114;46627;47464;47493.52506475029;47518;7158.3557479824985;7351.41188704913;7441.367483763941;7505.66224519887;7560.621968901423;11326.093912486816;12126.575569855013;12137;12190.51237950472;12333.444994975069;9438;10018.699439016842;10259.589616415558;10307.690769276935;10643.893561064291;9542.475163866055;9938.204943604638;9989.200863930722;10303.845442318521;10562.366258024544;9248.676296329866;9278.582463789011;9448.763780905532;9905.702828915144;10344.689659309932;7251.456140789567;7384.593847338448;7426.4430167736555;7854.096778870275;10363.689089327332;10528.736781580521;10540.209484288862;10799.244052916221;11062.115030797679;11197.944010280222 11:14:15 INFO - PROCESS | 24113 | |3;mootools.html;1049.8635177426934;1320.894328453724;1366.7676494995849;1368.5210176438247;1706.8293170682932;6522.380373864481;7101.254368291333;7777.688892444309;8087.878681819762;8101.108878023428;8123.837523249546;8187.959060204706;8190.8771368429525;8197.754067377973;8198.508089514618;2151.34384012876;2173.261091228982;2173.6848157017225;2173.793489618484;2180.694702741617;2157.223399576151;2173.076442511934;2200.6919031335624;2203.4711669199355;2206.5035367042447;2159.341400872733;2171.913123475059;2182.9563408731815;2183.6069507488646;2200.658897870833;2055.095757866549;2055.7533096028424;2055.9794402055936;2058.135583055113;2059.773424923265;2117.174302022197;2161.070739581979;2161.55688083944;2161.5892980333842;2166.7724888886755;7982.560959147245;8032.4778889372;8162.918370816335;8279.751607451786;8300.875486867702;4411.911761764747;4560.840370587013;4583.381243532114;4627.583517483409;4629.907401851944;2838.659360876708;2991.1026691992315;2991.2820922978544;3044.1324222596454;3061;836.5524444422205;847.2163248994717;857.7169534053747;878.5519385113574;891.9821603567892;11022.393768342738;11100.55597776088;11116.610918617891;11145.498452569573;11154.609588664358;3810.733248672622;3964.5837187095517;4093.871186982752;4112.527059388209;4116.547179810218;8595.78510537229;8606.956965215133;8610.095939926343;8619.741407757778;8620.094890036456;4439.400680908101;4462.576055274743;4463.598276155161;4463.955360446419;4468.642508599304;3575.3743094958277;3682.5396825396824;3954.9011274718364;4141.461609990682;4157.854475093357;3382.4926261061037;3430.9828450857585;3512.3853325667906;3546.3793836078585;3568.411212149966;998.6654470752234;1024.9436281004466;1033.617561502249;1034.8551202831609;1036.290141253244;579.3945327133156;596.472122171881;699.597731304502;705.872942870278;721.4913485992363;5148.4851514848215;5240.240165176028;5268.9736551317765;5288.65623734456;5419.701916394636;835.4653022065883;866.1468453573225;876.2508055612487;879.9120087991149;881.259741816877;3458;3597.9100522487147;3613.2773445311045;3624.8731294405097;3706.592274849764;9598.376105553116;10001.999800020085;10061.79876402468;10132.898671013343;10139.188864890792;9978.401295922267;10054.547545360476;10055.29612927088;10058.435099049695;10065.245106617032;7302.780916572511;7374.963125184447;7392.667329970164;7464;7501.249875012455;5043.218301163325;5253.605979551472;5295.179247216687;5367.624266301322;5376.8118115865755;8815.647374104963;9099.909000909905;9211.40125891815;9285.907140928775;9306.162445379949;9215.677451289173;9442.480663563296;9467.384619999679;9480.336376453582;9510.714678559654;6266.624002559861;6299.275583307978;6333.904991425225;6378.553501254868;6379.840503987438;6831.9658401707675;6935.514513984174;6936.445084393135;6937.791866244021;6943.930560694328;6365.331640177715;6669.166354205724;6717.093192418961;6735.393814556714;6841.589504629539;6507.739690412331;6512.251091124582;6513.869722605426;6518.641474718746;6524.119243902012;6091.634501929899;6189.35011823752;6196.597221180609;6198.597091189058;6202.100695399052;4191.41320215164;4220.5146408163455;4308.935365969451;4480.439945006874;4487.205117952845;4515.34527493505;4594.977025114853;4660.883477913079;4674.22875225584;4717.693349932243 11:14:15 INFO - PROCESS | 24113 | |4;prototype.html;295.37822882831637;295.8476384661899;304.9722435392726;306.7668571885368;308.84403376294966;4859.955109651424;4872.221639101725;4878.024395120977;4882.02359528094;4919.286703428005;4789.664723469358;4792.281157826319;4832.106060378833;4835.927461088087;4835.927461088087;3824.139568597071;3832.5975772543898;3845.4616353710503;3845.8653947111857;3849.191669749342;3697;3780.1116737566786;3849.576546579874;3859.8842034739005;3862.2275544890995;3744.850205991757;3784.8864534064023;3793.8103094845287;3794.146317078663;3804.2771873344113;3765.8305376258136;3780.432935059749;3781.470594116798;3790.3935370340887;3791.469194312798;3130.843457827122;3218.340240250743;3233.3856567252146;3356.7146792522667;3361.3613413451612;4594;4625.375574297461;4627.722336659777;4635.9536404635855;4640.05356598559;4233.491980962273;4266.210751011073;4266.893327666802;4270.167317373113;4275.273203555403;4633.235516139833;4708.693934894221;4964.329815474937;4968.552830245259;4985.401751789772;3640.672339489432;3654.400415590641;3655.4516822476576;3655.5065066215984;3661.4690869823726;5231.424543300234;5236.6857988520815;5238.999999999962;5241.528262456359;5244.554212891909;3584.874529391459;3729.9440508392395;3730.2912446635596;3737.831797569116;3748.775073495599;3794.44427784607;3806.371948628501;3807.0584002158544;3807.809609519513;3811.5807261201244;4221.6200541951375;4233.661307095425;4236.585146466485;4237.618614324726;4248.171606536695;4963.146190940224;4964.758810297426;4985.8781774100535;4996.775145118479;5002.174206414633;1263.5388083349512;1314.9276789776654;1318.9843820258347;1320.650027742649;1320.7556602028656;815.5799763121997;846.8983721953282;847.7414388611533;852.8251708399763;861;3880.553736320303;3893.4159876018257;3896.8246428910766;3916.7258291919293;3922.470466486988;4519.706219095749;4532.184206842734;4535.523770004102;4557.772111394417;4563.817447302137;3904.652894751306;3908.905506458196;3911.647951684362;3953.6244056814558;3968.8412463501713;2292.9656055159185;2368.827430421952;2412.481316516957;2415.8308918375546;2444.1811992982193;4270.167317373082;4600.723956562617;4675.4155730533685;4758.833440829623;4798.5441383068555;5257.815976440883;5294.152935530296;5298.549623282064;5304.602154838402;5307.310049693515;4823.807047718122;4827.227643577081;4830.227163653799;4847.491013443538;4851.46633870281;4897.730624815669;5096.23556466533;5128.897422051613;5151.6908985461;5196.142636464941;5042.9243561345875;5071.644984851173;5074.82238121664;5087.389513258433;5087.949120508748;4787.760611969318;4800.823798169471;4804.279358096313;4823.397075365579;4835.637327200544;3504.4392897136336;3676.889693309205;3691.833867475916;3693.5937046925355;3722.1625134344554;5137.743112844418;5148.352527191412;5174.534291913746;5191.792328306826;5194.792208311776;5028;5028.673136246132;5042.294078828893;5045.536794329603;5048.268001139888;4936.703797772145;4976.552110310089;5002.649814512949;5010.69935803853;5025.773840177128;4930.482299358516;4943.184374578154;4948.406191256928;4952.826651067196;4966.329545511309;5025.422076461254;5026.095302845377;5064.797408103635;5076.771545280545;5078.9238161426865;4781.521847815191;4906;4925.778339974638;4937.629677774109;4951.900961980812 11:14:15 INFO - PROCESS | 24113 | |5;yui.html;509.666168659528;557.7127779193713;563.4956713741202;568.1988396361131;586.7506309818332;10386.948065259672;11258.718532036703;11261.380624065672;11325.943370283147;11339.716507087327;10991.340519568832;11408.144389170804;11703.06375489961;11767.35279559626;11999.340036298001;760.1068744225527;779.9649015794274;781.5701364249668;782.6751897962339;782.9138794732575;491.51585688097197;498.77305825849334;748.3788455581854;771.8687823070063;781.0588241169377;813.4021494201756;814.450246083894;814.5886327404652;815.0260438775665;815.388458656008;813.0609146435876;813.2152472863685;814.0069115678863;814.0678922633551;814.633414963263;369.3775987461137;376.77958394339345;568.1506148308264;586.5307753796988;593.9524838012992;12373.319467429288;12424.813627795591;12446.377681115999;12451.003919686404;12458.688532786662;12080;12445.62663120108;12560.685982850411;12726.87273127266;13168;11080.833787493195;11122.49948752308;11160.776784464266;11311.83032254517;11323.150763692756;4109.609587089251;4166.708330416872;4201.495820501529;4242.575742425764;4398.670099742532;60896.39103608952;61372.38627613711;61851;62260.68869655668;62397;9851.359661621971;10118.241131915136;10155.847662285072;10191.388516689023;10417.687469375931;15479.5356139316;15486.922565387102;15506;15509.224538773016;15520.844791552166;5915.585908986416;6041;6093.817185484442;6204.689765511706;6236.563440559117;3456.723462123024;3523.0839981604454;3524.9118772030906;3552.484889691032;3581.8925432237074;2670.9866450667623;2769.1692492252246;2773.3482631581564;2774.029089818547;2775.320046588599;478.4569513602087;482.30788818046216;483.2799129297322;485.87367284506286;494.71553856532637;442.31882900333767;457.6887716352845;470.3532642616402;479.8374104642215;492.6452953873206;6954.200266969262;7011.684474198673;7197.89203161953;7491.250874912575;7547.811304717426;472.34344261476576;474.98100075997263;497.12009742755123;498.12081675842165;529.4282175250797;3129.342838003999;3173.3494633600058;3248.6264079631146;3295.8516866740574;3463.6016858061644;57134.714326428104;92590.53704731568;97352;107791;107819.46090269655;51211;64841.67579162168;72602.63698681473;79921;84791.66042596487;46740.532594674296;47453.76273118681;52276.73861630668;63909;82894.58552707318;8338.207870252316;8616.827663446822;8872.955635221782;8923.107689231025;8943.686970955985;42578.36132458078;43934.14428062166;44272;44836.551634483236;45502.77248613736;38707.80646096751;39462.21075578415;39558.40662390124;53974.73012634912;63584.3641563597;12187.51249949992;12192.451339689913;12407.193532420364;12604.810927835906;12795.872041279468;10973.451327433757;11536.077113830706;11826.053915686896;12725.300108493751;12872.485100595872;11113.22207445471;11691.649250522498;11699.941500292443;11765.941170294094;11905.583304584645;11417.1437142213;12253.509859605516;12582.496700132258;12718.809217861924;13366.897922691654;10764.40795756241;11252;11319.037881780141;11323.377214252965;11331.376774277494;9597.328187026842;9788.755281118029;9831.705048848546;9992.700218993441;10432.634857779942;8917.331200160144;8967.237784788365;9075.636974521209;9599.712008639752;9675.419474831533 11:14:15 INFO - PROCESS | 24113 | __end_tp_report 11:14:15 INFO - PROCESS | 24113 | __start_cc_report 11:14:15 INFO - PROCESS | 24113 | _x_x_mozilla_cycle_collect,967 11:14:15 INFO - PROCESS | 24113 | __end_cc_report 11:14:15 INFO - PROCESS | 24113 | __startTimestamp1475000055577__endTimestamp 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | ------- Summary: start ------- 11:14:15 INFO - PROCESS | 24113 | Number of tests: 6 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#0] dojo.html Cycles:165 Average:4727.40 Median:4854.39 stddev:500.56 (10.3%) stddev-sans-first:473.58 11:14:15 INFO - PROCESS | 24113 | Values: 2604.2 2620.1 2655.4 2662.9 2677.8 4586.6 4675.4 4743.5 4827.6 4900.6 4707.8 4787.9 4818.5 4840.9 4864.0 4317.4 4339.2 4369.7 4396.5 4410.6 4385.2 4478.5 4485.0 4494.6 4501.5 4416.8 4451.7 4468.5 4493.4 4503.7 4297.0 4321.4 4336.4 4346.8 4374.5 4322.8 4331.1 4339.1 4429.2 4433.1 4783.8 4796.9 4847.7 4849.5 4892.0 4902.2 4951.1 5007.2 5138.9 5147.7 5081.2 5116.9 5118.7 5119.2 5177.8 4738.5 4765.6 4774.6 4775.5 4809.7 5064.5 5122.4 5170.5 5259.5 5361.0 4997.5 5017.8 5017.9 5063.7 5084.6 5106.2 5111.5 5113.4 5114.2 5179.9 4946.2 5021.6 5041.6 5046.2 5046.5 5036.4 5046.5 5055.1 5057.2 5109.7 4353.8 4362.1 4398.8 4408.9 4415.2 3791.1 3792.2 3814.2 3823.2 3840.4 4199.1 4244.8 4424.1 4427.4 4429.6 5105.8 5159.8 5159.9 5168.9 5220.4 4339.7 4377.8 4382.7 4382.8 4434.8 4473.2 4618.9 4620.2 4622.2 4677.5 4680.1 4731.6 4810.4 4820.4 4840.4 5203.1 5203.5 5219.2 5223.3 5250.0 4791.3 4828.3 4832.5 4833.9 4893.4 4936.9 5003.2 5011.4 5064.8 5114.0 5166.8 5169.8 5172.4 5172.8 5223.6 5035.4 5040.1 5047.6 5047.6 5112.3 4870.3 4938.0 4939.1 4979.7 5108.8 4922.3 4945.9 4949.9 5003.3 5012.7 4854.4 5005.9 5053.0 5053.0 5120.9 4788.5 4854.9 4867.9 4896.5 4903.3 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#1] ext.html Cycles:180 Average:46696.41 Median:35003.15 stddev:88776.36 (253.6%) stddev-sans-first:88957.71 11:14:15 INFO - PROCESS | 24113 | Values: 522.4 546.9 568.3 568.5 572.3 25253.4 37360.8 38804.0 38823.6 43640.8 39456.8 39785.4 39842.2 39941.0 39947.4 7144.9 7685.1 7834.6 7835.6 7841.9 7139.1 9738.6 9982.8 9990.9 10352.7 10166.9 10218.8 10222.7 10223.0 10234.5 10041.4 10109.7 10121.5 10123.4 10128.4 9594.7 9673.4 9675.3 9676.9 9680.8 37274.0 37593.1 37601.0 37837.2 37870.2 2623.2 2684.9 2733.2 2911.9 3050.5 28470.4 28656.3 28734.0 28818.4 29903.7 3462.6 3484.7 3553.3 3591.5 3602.4 250134.7 250321.0 250704.0 251775.0 253247.0 30874.7 32147.8 51241.0 51627.7 51680.7 33566.7 33670.2 33696.2 33718.7 33851.2 11907.2 11978.1 12023.9 12026.2 12028.2 8076.9 8244.9 9289.9 9865.8 9940.3 7557.2 7679.0 7769.0 7771.5 7791.3 3005.2 3041.9 3057.5 3061.3 3130.1 882.0 894.3 909.9 952.1 973.9 26993.7 27380.9 27602.7 27900.9 27983.6 936.4 944.7 957.9 959.0 1029.9 13757.2 14897.9 15133.0 15137.9 15181.5 389342.0 391248.0 391352.0 391393.0 391785.0 31462.2 31647.5 31743.5 31768.5 31777.7 951.0 975.3 992.7 1152.4 1181.8 27149.6 28478.9 29089.6 29207.6 29587.6 41026.8 45059.5 46878.3 46932.8 52526.2 346023.0 350680.0 351070.0 351946.0 352053.0 24203.6 24779.9 24899.4 26270.5 38173.4 40461.0 40865.4 40866.2 41659.6 41769.8 35030.0 35044.0 35100.5 35196.0 35235.3 33521.0 34717.7 34798.7 34952.0 35046.8 34780.1 34856.5 34976.3 35306.1 36158.5 29849.9 31697.4 31853.2 32322.5 32496.0 23870.0 24233.6 24716.5 25173.5 25551.9 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#2] jquery.html Cycles:180 Average:23092.84 Median:4092.90 stddev:60359.79 (1474.7%) stddev-sans-first:60504.92 11:14:15 INFO - PROCESS | 24113 | Values: 330.4 366.6 368.2 370.1 393.7 11649.5 12630.4 14238.4 16478.5 17064.7 15613.7 15706.8 16031.8 16349.1 16386.3 4812.1 4944.9 4988.0 5008.8 5055.9 3623.1 3822.1 5023.2 5035.4 5082.8 3799.9 3845.4 3850.7 3943.5 5852.9 5907.9 5924.4 5927.7 5928.6 5928.9 5004.9 5142.7 5161.0 5165.2 5216.7 19812.9 20102.7 20164.7 20614.5 20804.4 1932.3 2065.1 2229.0 2376.4 2474.6 8580.7 11412.0 13231.1 13738.5 13938.4 1627.4 1760.8 1788.3 1867.8 1868.1 59585.7 61108.7 63415.0 66501.7 71552.6 9549.7 9570.2 9598.6 9769.3 9983.3 12753.9 12782.7 12792.3 12857.9 12881.9 6526.7 6684.4 6747.4 6764.6 6783.5 6116.2 6174.8 6198.7 6313.5 6317.3 4029.5 4031.3 4088.5 4097.3 4348.1 1599.8 1672.8 1724.9 1725.7 1727.9 738.6 778.9 781.0 816.2 848.9 15596.2 16496.9 16672.2 17389.0 17400.0 751.3 753.1 766.4 801.0 847.8 8809.0 9088.2 9320.9 9332.0 9339.7 362350.0 364242.0 365614.0 367478.0 367593.0 73590.0 74275.0 74859.6 77356.0 77588.6 814.5 839.9 841.2 842.8 843.7 13961.9 14177.6 14562.5 15115.7 15159.6 33152.5 34881.0 34895.5 35259.8 35477.5 44999.1 46627.0 47464.0 47493.5 47518.0 7158.4 7351.4 7441.4 7505.7 7560.6 11326.1 12126.6 12137.0 12190.5 12333.4 9438.0 10018.7 10259.6 10307.7 10643.9 9542.5 9938.2 9989.2 10303.8 10562.4 9248.7 9278.6 9448.8 9905.7 10344.7 7251.5 7384.6 7426.4 7854.1 10363.7 10528.7 10540.2 10799.2 11062.1 11197.9 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#3] mootools.html Cycles:180 Average:5117.61 Median:4695.96 stddev:2971.08 (63.3%) stddev-sans-first:2963.68 11:14:15 INFO - PROCESS | 24113 | Values: 1049.9 1320.9 1366.8 1368.5 1706.8 6522.4 7101.3 7777.7 8087.9 8101.1 8123.8 8188.0 8190.9 8197.8 8198.5 2151.3 2173.3 2173.7 2173.8 2180.7 2157.2 2173.1 2200.7 2203.5 2206.5 2159.3 2171.9 2183.0 2183.6 2200.7 2055.1 2055.8 2056.0 2058.1 2059.8 2117.2 2161.1 2161.6 2161.6 2166.8 7982.6 8032.5 8162.9 8279.8 8300.9 4411.9 4560.8 4583.4 4627.6 4629.9 2838.7 2991.1 2991.3 3044.1 3061.0 836.6 847.2 857.7 878.6 892.0 11022.4 11100.6 11116.6 11145.5 11154.6 3810.7 3964.6 4093.9 4112.5 4116.5 8595.8 8607.0 8610.1 8619.7 8620.1 4439.4 4462.6 4463.6 4464.0 4468.6 3575.4 3682.5 3954.9 4141.5 4157.9 3382.5 3431.0 3512.4 3546.4 3568.4 998.7 1024.9 1033.6 1034.9 1036.3 579.4 596.5 699.6 705.9 721.5 5148.5 5240.2 5269.0 5288.7 5419.7 835.5 866.1 876.3 879.9 881.3 3458.0 3597.9 3613.3 3624.9 3706.6 9598.4 10002.0 10061.8 10132.9 10139.2 9978.4 10054.5 10055.3 10058.4 10065.2 7302.8 7375.0 7392.7 7464.0 7501.2 5043.2 5253.6 5295.2 5367.6 5376.8 8815.6 9099.9 9211.4 9285.9 9306.2 9215.7 9442.5 9467.4 9480.3 9510.7 6266.6 6299.3 6333.9 6378.6 6379.8 6832.0 6935.5 6936.4 6937.8 6943.9 6365.3 6669.2 6717.1 6735.4 6841.6 6507.7 6512.3 6513.9 6518.6 6524.1 6091.6 6189.4 6196.6 6198.6 6202.1 4191.4 4220.5 4308.9 4480.4 4487.2 4515.3 4595.0 4660.9 4674.2 4717.7 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#4] prototype.html Cycles:180 Average:4117.71 Median:4634.59 stddev:1201.16 (25.9%) stddev-sans-first:1169.77 11:14:15 INFO - PROCESS | 24113 | Values: 295.4 295.8 305.0 306.8 308.8 4860.0 4872.2 4878.0 4882.0 4919.3 4789.7 4792.3 4832.1 4835.9 4835.9 3824.1 3832.6 3845.5 3845.9 3849.2 3697.0 3780.1 3849.6 3859.9 3862.2 3744.9 3784.9 3793.8 3794.1 3804.3 3765.8 3780.4 3781.5 3790.4 3791.5 3130.8 3218.3 3233.4 3356.7 3361.4 4594.0 4625.4 4627.7 4636.0 4640.1 4233.5 4266.2 4266.9 4270.2 4275.3 4633.2 4708.7 4964.3 4968.6 4985.4 3640.7 3654.4 3655.5 3655.5 3661.5 5231.4 5236.7 5239.0 5241.5 5244.6 3584.9 3729.9 3730.3 3737.8 3748.8 3794.4 3806.4 3807.1 3807.8 3811.6 4221.6 4233.7 4236.6 4237.6 4248.2 4963.1 4964.8 4985.9 4996.8 5002.2 1263.5 1314.9 1319.0 1320.7 1320.8 815.6 846.9 847.7 852.8 861.0 3880.6 3893.4 3896.8 3916.7 3922.5 4519.7 4532.2 4535.5 4557.8 4563.8 3904.7 3908.9 3911.6 3953.6 3968.8 2293.0 2368.8 2412.5 2415.8 2444.2 4270.2 4600.7 4675.4 4758.8 4798.5 5257.8 5294.2 5298.5 5304.6 5307.3 4823.8 4827.2 4830.2 4847.5 4851.5 4897.7 5096.2 5128.9 5151.7 5196.1 5042.9 5071.6 5074.8 5087.4 5087.9 4787.8 4800.8 4804.3 4823.4 4835.6 3504.4 3676.9 3691.8 3693.6 3722.2 5137.7 5148.4 5174.5 5191.8 5194.8 5028.0 5028.7 5042.3 5045.5 5048.3 4936.7 4976.6 5002.6 5010.7 5025.8 4930.5 4943.2 4948.4 4952.8 4966.3 5025.4 5026.1 5064.8 5076.8 5078.9 4781.5 4906.0 4925.8 4937.6 4951.9 11:14:15 INFO - PROCESS | 24113 | 11:14:15 INFO - PROCESS | 24113 | [#5] yui.html Cycles:180 Average:16105.00 Median:44554.28 stddev:22780.64 (51.1%) stddev-sans-first:22814.45 11:14:15 INFO - PROCESS | 24113 | Values: 509.7 557.7 563.5 568.2 586.8 10386.9 11258.7 11261.4 11325.9 11339.7 10991.3 11408.1 11703.1 11767.4 11999.3 760.1 780.0 781.6 782.7 782.9 491.5 498.8 748.4 771.9 781.1 813.4 814.5 814.6 815.0 815.4 813.1 813.2 814.0 814.1 814.6 369.4 376.8 568.2 586.5 594.0 12373.3 12424.8 12446.4 12451.0 12458.7 12080.0 12445.6 12560.7 12726.9 13168.0 11080.8 11122.5 11160.8 11311.8 11323.2 4109.6 4166.7 4201.5 4242.6 4398.7 60896.4 61372.4 61851.0 62260.7 62397.0 9851.4 10118.2 10155.8 10191.4 10417.7 15479.5 15486.9 15506.0 15509.2 15520.8 5915.6 6041.0 6093.8 6204.7 6236.6 3456.7 3523.1 3524.9 3552.5 3581.9 2671.0 2769.2 2773.3 2774.0 2775.3 478.5 482.3 483.3 485.9 494.7 442.3 457.7 470.4 479.8 492.6 6954.2 7011.7 7197.9 7491.3 7547.8 472.3 475.0 497.1 498.1 529.4 3129.3 3173.3 3248.6 3295.9 3463.6 57134.7 92590.5 97352.0 107791.0 107819.5 51211.0 64841.7 72602.6 79921.0 84791.7 46740.5 47453.8 52276.7 63909.0 82894.6 8338.2 8616.8 8873.0 8923.1 8943.7 42578.4 43934.1 44272.0 44836.6 45502.8 38707.8 39462.2 39558.4 53974.7 63584.4 12187.5 12192.5 12407.2 12604.8 12795.9 10973.5 11536.1 11826.1 12725.3 12872.5 11113.2 11691.6 11699.9 11765.9 11905.6 11417.1 12253.5 12582.5 12718.8 13366.9 10764.4 11252.0 11319.0 11323.4 11331.4 9597.3 9788.8 9831.7 9992.7 10432.6 8917.3 8967.2 9075.6 9599.7 9675.4 11:14:15 INFO - PROCESS | 24113 | -------- Summary: end -------- 11:14:15 INFO - PROCESS | 24113 | 11:14:16 INFO - TEST-INFO | 24113: exit 0 11:14:16 INFO - TEST-OK | dromaeo_css | took 1120831ms 11:14:16 INFO - TEST-START | kraken 11:14:16 INFO - operating with platform_type : linux_ 11:14:16 INFO - Initialising browser for kraken test... 11:14:16 INFO - TEST-INFO | started process 24421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInxt_j/profile http://localhost:48970/getInfo.html) 11:14:20 INFO - PROCESS | 24421 | __metrics Screen width/height:1600/1200 11:14:20 INFO - PROCESS | 24421 | colorDepth:24 11:14:20 INFO - PROCESS | 24421 | Browser inner width/height: 1024/697 11:14:20 INFO - PROCESS | 24421 | __metrics 11:14:21 INFO - PROCESS | 24421 | 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" 11:14:21 INFO - PROCESS | 24421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:21 INFO - PROCESS | 24421 | console.error: PushService: 11:14:21 INFO - PROCESS | 24421 | stateChangeProcessEnqueue: Error transitioning state 11:14:21 INFO - PROCESS | 24421 | UnknownError 11:14:22 INFO - TEST-INFO | 24421: exit 0 11:14:22 INFO - Browser initialized. 11:14:22 INFO - Running cycle 1/1 for kraken test... 11:14:22 INFO - TEST-INFO | started process 24501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInxt_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:34 INFO - PROCESS | 24501 | RSS: Main: 175243264 11:14:34 INFO - PROCESS | 24501 | 11:14:37 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48970/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:38 INFO - PROCESS | 24501 | RSS: Main: 234418176 11:14:38 INFO - PROCESS | 24501 | 11:14:41 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48970/tests/kraken/driver.html?testName=audio-dft) 11:14:41 INFO - PROCESS | 24501 | RSS: Main: 218898432 11:14:41 INFO - PROCESS | 24501 | 11:14:45 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48970/tests/kraken/driver.html?testName=audio-fft) 11:14:45 INFO - PROCESS | 24501 | RSS: Main: 301002752 11:14:45 INFO - PROCESS | 24501 | 11:14:47 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48970/tests/kraken/driver.html?testName=audio-oscillator) 11:14:48 INFO - PROCESS | 24501 | RSS: Main: 210784256 11:14:48 INFO - PROCESS | 24501 | 11:14:50 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:51 INFO - PROCESS | 24501 | RSS: Main: 214228992 11:14:51 INFO - PROCESS | 24501 | 11:14:54 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48970/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:55 INFO - PROCESS | 24501 | RSS: Main: 251019264 11:14:55 INFO - PROCESS | 24501 | 11:14:58 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48970/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:59 INFO - PROCESS | 24501 | RSS: Main: 244994048 11:14:59 INFO - PROCESS | 24501 | 11:15:02 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48970/tests/kraken/driver.html?testName=json-parse-financial) 11:15:02 INFO - PROCESS | 24501 | RSS: Main: 247889920 11:15:02 INFO - PROCESS | 24501 | 11:15:04 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:04 INFO - PROCESS | 24501 | RSS: Main: 211169280 11:15:04 INFO - PROCESS | 24501 | 11:15:06 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:07 INFO - PROCESS | 24501 | RSS: Main: 219119616 11:15:07 INFO - PROCESS | 24501 | 11:15:09 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:10 INFO - PROCESS | 24501 | RSS: Main: 222642176 11:15:10 INFO - PROCESS | 24501 | 11:15:13 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:13 INFO - PROCESS | 24501 | RSS: Main: 217726976 11:15:13 INFO - PROCESS | 24501 | 11:15:16 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:17 INFO - PROCESS | 24501 | RSS: Main: 222216192 11:15:17 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | Cycle 1(1): loaded http://localhost:48970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48970/tests/kraken/driver.html?testName=ai-astar) 11:15:19 INFO - PROCESS | 24501 | RSS: Main: 272883712 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | __start_tp_report 11:15:19 INFO - PROCESS | 24501 | _x_x_mozilla_page_load 11:15:19 INFO - PROCESS | 24501 | _x_x_mozilla_page_load_details 11:15:19 INFO - PROCESS | 24501 | |i|pagename|runs| 11:15:19 INFO - PROCESS | 24501 | |0;ai-astar;110;114;114;113;114;114;113;115;113;113 11:15:19 INFO - PROCESS | 24501 | |1;audio-beat-detection;151;122;131;175;126;123;124;122;161;124 11:15:19 INFO - PROCESS | 24501 | |2;audio-dft;161;162;163;162;160;161;163;164;164;164 11:15:19 INFO - PROCESS | 24501 | |3;audio-fft;75;77;76;114;76;77;77;76;115;76 11:15:19 INFO - PROCESS | 24501 | |4;audio-oscillator;84;83;116;84;83;84;105;89;83;113 11:15:19 INFO - PROCESS | 24501 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;117 11:15:19 INFO - PROCESS | 24501 | |6;imaging-darkroom;146;147;145;145;146;146;147;146;147;146 11:15:19 INFO - PROCESS | 24501 | |7;imaging-desaturate;95;94;94;95;95;94;94;94;95;95 11:15:19 INFO - PROCESS | 24501 | |8;json-parse-financial;63;62;62;61;63;63;63;63;63;62 11:15:19 INFO - PROCESS | 24501 | |9;json-stringify-tinderbox;66;67;66;67;67;66;67;66;67;67 11:15:19 INFO - PROCESS | 24501 | |10;stanford-crypto-aes;92;83;84;89;84;85;89;83;83;90 11:15:19 INFO - PROCESS | 24501 | |11;stanford-crypto-ccm;138;144;136;133;145;143;134;136;187;133 11:15:19 INFO - PROCESS | 24501 | |12;stanford-crypto-pbkdf2;177;173;172;176;172;172;170;173;171;171 11:15:19 INFO - PROCESS | 24501 | |13;stanford-crypto-sha256-iterative;69;72;69;68;74;70;70;69;70;70 11:15:19 INFO - PROCESS | 24501 | __end_tp_report 11:15:19 INFO - PROCESS | 24501 | __start_cc_report 11:15:19 INFO - PROCESS | 24501 | _x_x_mozilla_cycle_collect,1921 11:15:19 INFO - PROCESS | 24501 | __end_cc_report 11:15:19 INFO - PROCESS | 24501 | __startTimestamp1475000119435__endTimestamp 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | ------- Summary: start ------- 11:15:19 INFO - PROCESS | 24501 | Number of tests: 14 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:0.71 11:15:19 INFO - PROCESS | 24501 | Values: 110.0 114.0 114.0 113.0 114.0 114.0 113.0 115.0 113.0 113.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:128.50 stddev:19.28 (15.0%) stddev-sans-first:19.66 11:15:19 INFO - PROCESS | 24501 | Values: 151.0 122.0 131.0 175.0 126.0 123.0 124.0 122.0 161.0 124.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 11:15:19 INFO - PROCESS | 24501 | Values: 161.0 162.0 163.0 162.0 160.0 161.0 163.0 164.0 164.0 164.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:16.14 (21.2%) stddev-sans-first:16.80 11:15:19 INFO - PROCESS | 24501 | Values: 75.0 77.0 76.0 114.0 76.0 77.0 77.0 76.0 115.0 76.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.50 stddev:13.45 (16.1%) stddev-sans-first:13.92 11:15:19 INFO - PROCESS | 24501 | Values: 84.0 83.0 116.0 84.0 83.0 84.0 105.0 89.0 83.0 113.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:15:19 INFO - PROCESS | 24501 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:15:19 INFO - PROCESS | 24501 | Values: 146.0 147.0 145.0 145.0 146.0 146.0 147.0 146.0 147.0 146.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:15:19 INFO - PROCESS | 24501 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 11:15:19 INFO - PROCESS | 24501 | Values: 63.0 62.0 62.0 61.0 63.0 63.0 63.0 63.0 63.0 62.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:15:19 INFO - PROCESS | 24501 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:3.43 (3.9%) stddev-sans-first:2.92 11:15:19 INFO - PROCESS | 24501 | Values: 92.0 83.0 84.0 89.0 84.0 85.0 89.0 83.0 83.0 90.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.50 stddev:16.14 (11.5%) stddev-sans-first:17.02 11:15:19 INFO - PROCESS | 24501 | Values: 138.0 144.0 136.0 133.0 145.0 143.0 134.0 136.0 187.0 133.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.50 stddev:2.21 (1.3%) stddev-sans-first:1.72 11:15:19 INFO - PROCESS | 24501 | Values: 177.0 173.0 172.0 176.0 172.0 172.0 170.0 173.0 171.0 171.0 11:15:19 INFO - PROCESS | 24501 | 11:15:19 INFO - PROCESS | 24501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.73 (2.5%) stddev-sans-first:1.79 11:15:19 INFO - PROCESS | 24501 | Values: 69.0 72.0 69.0 68.0 74.0 70.0 70.0 69.0 70.0 70.0 11:15:19 INFO - PROCESS | 24501 | -------- Summary: end -------- 11:15:19 INFO - PROCESS | 24501 | 11:15:20 INFO - TEST-INFO | 24501: exit 0 11:15:20 INFO - TEST-OK | kraken | took 64200ms 11:15:20 INFO - SUITE-END | took 1185s 11:15:21 INFO - Completed test suite (00:19:45) 11:15:21 INFO - javascript benchmark 11:15:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.244769016985, 2620.0960668569337, 2655.402534429753, 2662.8934842606286, 2677.7590016898475, 4586.633069354452, 4675.4155730533685, 4743.4782173960875, 4827.58965487934, 4900.558949694527, 4707.78814953327, 4787.856364309067, 4818.51814818518, 4840.878978025542, 4864.027194561084, 4317.395564620955, 4339.175556644243, 4369.672274579403, 4396.450443694538, 4410.62509686677, 4385.21066208084, 4478.484974227957, 4484.955150448486, 4494.573015563533, 4501.482329532097, 4416.823327066913, 4451.732896026233, 4468.463784345883, 4493.415855938707, 4503.707259028169, 4296.978515107405, 4321.373400856858, 4336.392904993303, 4346.782660866944, 4374.4531933508315, 4322.762248076355, 4331.068820203672, 4339.06710057336, 4429.15845989261, 4433.069055498349, 4783.760811959388, 4796.8560943171415, 4847.684900481493, 4849.515048495157, 4891.951080489185, 4902.166631672589, 4951.084049450863, 5007.24891266313, 5138.948610513922, 5147.6911385317, 5081.237814327844, 5116.923246151311, 5118.718470484122, 5119.206522988943, 5177.792888284464, 4738.549837765407, 4765.571098601143, 4774.594159496412, 4775.450823155312, 4809.735464549413, 5064.544191022752, 5122.385313762373, 5170.482951704799, 5259.47405259471, 5361.035013697572, 4997.475265097185, 5017.799288028511, 5017.89964200714, 5063.721495317793, 5084.593232541388, 5106.183010718267, 5111.514406131411, 5113.437521872591, 5114.207297868837, 5179.870503237374, 4946.183879659888, 5021.59827213822, 5041.647084704109, 5046.1673823818655, 5046.470120637354, 5036.370453693288, 5046.495350464924, 5055.115354812967, 5057.241413787961, 5109.693418394908, 4353.804078816461, 4362.1493808707, 4398.846040388571, 4408.911821763547, 4415.249407600716, 3791.1469919267943, 3792.229395223549, 3814.2371525694416, 3823.235352929425, 3840.4047372657283, 4199.139176468817, 4244.766537840448, 4424.070945101565, 4427.424434823452, 4429.55704429561, 5105.770240339194, 5159.767810448464, 5159.896802064013, 5168.948310516922, 5220.399654039834, 4339.7396156230725, 4377.759223242752, 4382.737035777864, 4382.780860956939, 4434.778261086933, 4473.194824931544, 4618.930716039262, 4620.168369693488, 4622.168009758208, 4677.4854765975715, 4680.063987202573, 4731.597814185695, 4810.39870016248, 4820.39745031871, 4840.443349014768, 5203.115470370122, 5203.505666961632, 5219.243209734491, 5223.320968274252, 5249.973750131225, 4791.257355109963, 4828.348172996601, 4832.468428472795, 4833.903321933612, 4893.363862697826, 4936.901261974668, 5003.199488081889, 5011.398632164163, 5064.772085256099, 5114.0, 5166.844994650167, 5169.767360468863, 5172.379314482136, 5172.767225474938, 5223.5559977402345, 5035.395752509722, 5040.067587496325, 5047.570956468741, 5047.64666473358, 5112.309838171799, 4870.2938073979785, 4937.97531012357, 4939.061578300111, 4979.651424400257, 5108.846734597968, 4922.335484709519, 4945.876353091202, 4949.876253093701, 5003.2745251938995, 5012.674176178537, 4854.393200849894, 5005.924911126263, 5053.0, 5053.0399224147295, 5120.871978200575, 4788.521147885183, 4854.878628034327, 4867.878303042452, 4896.461389247109, 4903.28902309156], "value": 4695.048783533151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.3783697400091, 546.9480399362059, 568.2640979930989, 568.4940403041293, 572.2732130194652, 25253.368665783364, 37360.81319593402, 38804.0, 38823.611763882356, 43640.781796090974, 39456.80271598645, 39785.403218951666, 39842.20315593686, 39941.0, 39947.40078898812, 7144.85710285794, 7685.116211635677, 7834.647440865147, 7835.569043702622, 7841.882371764428, 7139.071920650308, 9738.561764720605, 9982.800343993116, 9990.90009099907, 10352.741181470448, 10166.898331016706, 10218.795624087514, 10222.744431389237, 10223.0, 10234.488275586227, 10041.447720375376, 10109.696709098738, 10121.544530496109, 10123.392596444164, 10128.392296462162, 9594.66418675343, 9673.37123086997, 9675.322727409084, 9676.854847177297, 9680.806383872354, 37274.0, 37593.060173495884, 37601.0, 37837.24325513502, 37870.24259514822, 2623.2392606144194, 2684.865756712157, 2733.248356701903, 2911.898083567065, 3050.527168288919, 28470.430591388056, 28656.268746250626, 28734.0, 28818.42363152746, 29903.700962990308, 3462.5844898612327, 3484.686378225972, 3553.3248682750195, 3591.5331006968927, 3602.4056030754896, 250134.74932625404, 250321.0, 250704.0, 251775.0, 253247.0, 30874.69125308718, 32147.839260803546, 51241.0, 51627.74186129045, 51680.74159629178, 33566.664333356355, 33670.15824604405, 33696.15759606029, 33718.662813372044, 33851.153721156676, 11907.166498345032, 11978.101642376856, 12023.879761202452, 12026.218295810744, 12028.218165819193, 8076.8788468173025, 8244.876326855101, 9289.907100928904, 9865.802683946424, 9940.304178707565, 7557.168711441737, 7678.96160519205, 7768.961155194188, 7771.494852834548, 7791.259830316111, 3005.218643152796, 3041.8935337263533, 3057.4955132402906, 3061.341811510536, 3130.076627394924, 881.9514926678966, 894.3069121430943, 909.9272058235325, 952.0622187145656, 973.9220862330997, 26993.730062699513, 27380.863095684395, 27602.723972760417, 27900.860495697798, 27983.580246296322, 936.3539157980971, 944.7096260938825, 957.9377340472847, 959.0265880131672, 1029.8764148302103, 13757.17456952586, 14897.851021489647, 15133.0, 15137.924310378598, 15181.468648597245, 389342.0, 391248.0, 391352.0, 391393.0, 391785.0, 31462.213444664067, 31647.525287120712, 31743.52384714231, 31768.523472147936, 31777.682223177933, 950.9634498396642, 975.3465178330536, 992.7418871093423, 1152.3546813784308, 1181.787278289916, 27149.59275610828, 28478.857605712667, 29089.563656545593, 29207.561886572144, 29587.556186656788, 41026.79486602548, 45059.54940450554, 46878.29682554696, 46932.76533617447, 52526.212106817664, 346023.0, 350680.0, 351070.0, 351946.0, 352053.0, 24203.63694544548, 24779.87610061938, 24899.37751556153, 26270.474590508464, 38173.4273985896, 40461.0, 40865.38701919533, 40866.1826763469, 41659.583404166784, 41769.79115104527, 35030.0, 35044.0, 35100.473492897116, 35196.0, 35235.29529409449, 33521.0, 34717.65282347144, 34798.652013480554, 34952.0, 35046.82476587601, 34780.13049673779, 34856.47715284323, 34976.30047399089, 35306.11734706653, 36158.457623135146, 29849.850750746107, 31697.366052678357, 31853.20366990844, 32322.515162273055, 32496.0, 23870.0, 24233.63649545223, 24716.50566988686, 25173.496530069664, 25551.872240638677], "value": 16370.267050218044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4349562248555, 366.5711117991949, 368.1679404545728, 370.1080396245049, 393.71455694621403, 11649.534018639255, 12630.431630576635, 14238.359273832677, 16478.505644830646, 17064.744028839577, 15613.68772624547, 15706.764398534031, 16031.759523607156, 16349.100799456055, 16386.344546218166, 4812.0857037163005, 4944.9258261126115, 4988.0, 5008.799648014094, 5055.9241611375855, 3623.148560088377, 3822.10180607557, 5023.171176755831, 5035.420926593452, 5082.771275292602, 3799.924001519968, 3845.365514690073, 3850.711196660248, 3943.507061617298, 5852.882942341172, 5907.852303692421, 5924.377940316291, 5927.673977931212, 5928.64428134309, 5928.88142237155, 5004.874878128039, 5142.717150556718, 5161.019406312788, 5165.173572228426, 5216.660917040418, 19812.90093549523, 20102.69845952312, 20164.69752953707, 20614.484637884023, 20804.375868723964, 1932.2657390191778, 2065.0913598016823, 2228.9554208915893, 2376.3940195250275, 2474.616434452663, 8580.699675511327, 11412.0, 13231.139975901535, 13738.450461981509, 13938.37277322523, 1627.3897288516807, 1760.7622970899022, 1788.3383148235107, 1867.813218678135, 1868.0566314011473, 59585.702071489366, 61108.694456527875, 63415.0, 66501.66749166271, 71552.64223678848, 9549.713508594754, 9570.176797844653, 9598.616055357847, 9769.316147869724, 9983.306176714663, 12753.872461275269, 12782.68043298925, 12792.296423696785, 12857.935710321388, 12881.871181288254, 6526.738930442824, 6684.431823294977, 6747.426468750211, 6764.594124352555, 6783.457323414115, 6116.207951070365, 6174.783882564088, 6198.690065496708, 6313.526485513605, 6317.273513545909, 4029.516458024997, 4031.314676505001, 4088.509378874554, 4097.282975479279, 4348.065165989327, 1599.7680336351164, 1672.8243534428952, 1724.90513021785, 1725.6721222967597, 1727.9136043197789, 738.6085374751391, 778.9026371703537, 780.980475488106, 816.2368185746346, 848.8981322241247, 15596.220188990732, 16496.917515412348, 16672.166391680366, 17389.0, 17400.0, 751.3388218367911, 753.1226121568421, 766.3715753082419, 801.0267524957205, 847.7922908887363, 8809.0, 9088.182063614306, 9320.906790932004, 9331.953340233254, 9339.719808405758, 362350.0, 364242.0, 365614.0, 367478.0, 367593.0, 73590.0, 74275.0, 74859.62570187115, 77356.0, 77588.61205694049, 814.535714642648, 839.8698201778734, 841.2134654098315, 842.7724514381083, 843.700486327345, 13961.860381396462, 14177.574672759834, 14562.490312839, 15115.697686046438, 15159.621009474851, 33152.50271245885, 34881.0, 34895.47656785201, 35259.82370088133, 35477.46783798194, 44999.100018000114, 46627.0, 47464.0, 47493.52506475029, 47518.0, 7158.3557479824985, 7351.41188704913, 7441.367483763941, 7505.66224519887, 7560.621968901423, 11326.093912486816, 12126.575569855013, 12137.0, 12190.51237950472, 12333.444994975069, 9438.0, 10018.699439016842, 10259.589616415558, 10307.690769276935, 10643.893561064291, 9542.475163866055, 9938.204943604638, 9989.200863930722, 10303.845442318521, 10562.366258024544, 9248.676296329866, 9278.582463789011, 9448.763780905532, 9905.702828915144, 10344.689659309932, 7251.456140789567, 7384.593847338448, 7426.4430167736555, 7854.096778870275, 10363.689089327332, 10528.736781580521, 10540.209484288862, 10799.244052916221, 11062.115030797679, 11197.944010280222], "value": 7917.635374141617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1049.8635177426934, 1320.894328453724, 1366.7676494995849, 1368.5210176438247, 1706.8293170682932, 6522.380373864481, 7101.254368291333, 7777.688892444309, 8087.878681819762, 8101.108878023428, 8123.837523249546, 8187.959060204706, 8190.8771368429525, 8197.754067377973, 8198.508089514618, 2151.34384012876, 2173.261091228982, 2173.6848157017225, 2173.793489618484, 2180.694702741617, 2157.223399576151, 2173.076442511934, 2200.6919031335624, 2203.4711669199355, 2206.5035367042447, 2159.341400872733, 2171.913123475059, 2182.9563408731815, 2183.6069507488646, 2200.658897870833, 2055.095757866549, 2055.7533096028424, 2055.9794402055936, 2058.135583055113, 2059.773424923265, 2117.174302022197, 2161.070739581979, 2161.55688083944, 2161.5892980333842, 2166.7724888886755, 7982.560959147245, 8032.4778889372, 8162.918370816335, 8279.751607451786, 8300.875486867702, 4411.911761764747, 4560.840370587013, 4583.381243532114, 4627.583517483409, 4629.907401851944, 2838.659360876708, 2991.1026691992315, 2991.2820922978544, 3044.1324222596454, 3061.0, 836.5524444422205, 847.2163248994717, 857.7169534053747, 878.5519385113574, 891.9821603567892, 11022.393768342738, 11100.55597776088, 11116.610918617891, 11145.498452569573, 11154.609588664358, 3810.733248672622, 3964.5837187095517, 4093.871186982752, 4112.527059388209, 4116.547179810218, 8595.78510537229, 8606.956965215133, 8610.095939926343, 8619.741407757778, 8620.094890036456, 4439.400680908101, 4462.576055274743, 4463.598276155161, 4463.955360446419, 4468.642508599304, 3575.3743094958277, 3682.5396825396824, 3954.9011274718364, 4141.461609990682, 4157.854475093357, 3382.4926261061037, 3430.9828450857585, 3512.3853325667906, 3546.3793836078585, 3568.411212149966, 998.6654470752234, 1024.9436281004466, 1033.617561502249, 1034.8551202831609, 1036.290141253244, 579.3945327133156, 596.472122171881, 699.597731304502, 705.872942870278, 721.4913485992363, 5148.4851514848215, 5240.240165176028, 5268.9736551317765, 5288.65623734456, 5419.701916394636, 835.4653022065883, 866.1468453573225, 876.2508055612487, 879.9120087991149, 881.259741816877, 3458.0, 3597.9100522487147, 3613.2773445311045, 3624.8731294405097, 3706.592274849764, 9598.376105553116, 10001.999800020085, 10061.79876402468, 10132.898671013343, 10139.188864890792, 9978.401295922267, 10054.547545360476, 10055.29612927088, 10058.435099049695, 10065.245106617032, 7302.780916572511, 7374.963125184447, 7392.667329970164, 7464.0, 7501.249875012455, 5043.218301163325, 5253.605979551472, 5295.179247216687, 5367.624266301322, 5376.8118115865755, 8815.647374104963, 9099.909000909905, 9211.40125891815, 9285.907140928775, 9306.162445379949, 9215.677451289173, 9442.480663563296, 9467.384619999679, 9480.336376453582, 9510.714678559654, 6266.624002559861, 6299.275583307978, 6333.904991425225, 6378.553501254868, 6379.840503987438, 6831.9658401707675, 6935.514513984174, 6936.445084393135, 6937.791866244021, 6943.930560694328, 6365.331640177715, 6669.166354205724, 6717.093192418961, 6735.393814556714, 6841.589504629539, 6507.739690412331, 6512.251091124582, 6513.869722605426, 6518.641474718746, 6524.119243902012, 6091.634501929899, 6189.35011823752, 6196.597221180609, 6198.597091189058, 6202.100695399052, 4191.41320215164, 4220.5146408163455, 4308.935365969451, 4480.439945006874, 4487.205117952845, 4515.34527493505, 4594.977025114853, 4660.883477913079, 4674.22875225584, 4717.693349932243], "value": 4054.05088711969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.37822882831637, 295.8476384661899, 304.9722435392726, 306.7668571885368, 308.84403376294966, 4859.955109651424, 4872.221639101725, 4878.024395120977, 4882.02359528094, 4919.286703428005, 4789.664723469358, 4792.281157826319, 4832.106060378833, 4835.927461088087, 4835.927461088087, 3824.139568597071, 3832.5975772543898, 3845.4616353710503, 3845.8653947111857, 3849.191669749342, 3697.0, 3780.1116737566786, 3849.576546579874, 3859.8842034739005, 3862.2275544890995, 3744.850205991757, 3784.8864534064023, 3793.8103094845287, 3794.146317078663, 3804.2771873344113, 3765.8305376258136, 3780.432935059749, 3781.470594116798, 3790.3935370340887, 3791.469194312798, 3130.843457827122, 3218.340240250743, 3233.3856567252146, 3356.7146792522667, 3361.3613413451612, 4594.0, 4625.375574297461, 4627.722336659777, 4635.9536404635855, 4640.05356598559, 4233.491980962273, 4266.210751011073, 4266.893327666802, 4270.167317373113, 4275.273203555403, 4633.235516139833, 4708.693934894221, 4964.329815474937, 4968.552830245259, 4985.401751789772, 3640.672339489432, 3654.400415590641, 3655.4516822476576, 3655.5065066215984, 3661.4690869823726, 5231.424543300234, 5236.6857988520815, 5238.999999999962, 5241.528262456359, 5244.554212891909, 3584.874529391459, 3729.9440508392395, 3730.2912446635596, 3737.831797569116, 3748.775073495599, 3794.44427784607, 3806.371948628501, 3807.0584002158544, 3807.809609519513, 3811.5807261201244, 4221.6200541951375, 4233.661307095425, 4236.585146466485, 4237.618614324726, 4248.171606536695, 4963.146190940224, 4964.758810297426, 4985.8781774100535, 4996.775145118479, 5002.174206414633, 1263.5388083349512, 1314.9276789776654, 1318.9843820258347, 1320.650027742649, 1320.7556602028656, 815.5799763121997, 846.8983721953282, 847.7414388611533, 852.8251708399763, 861.0, 3880.553736320303, 3893.4159876018257, 3896.8246428910766, 3916.7258291919293, 3922.470466486988, 4519.706219095749, 4532.184206842734, 4535.523770004102, 4557.772111394417, 4563.817447302137, 3904.652894751306, 3908.905506458196, 3911.647951684362, 3953.6244056814558, 3968.8412463501713, 2292.9656055159185, 2368.827430421952, 2412.481316516957, 2415.8308918375546, 2444.1811992982193, 4270.167317373082, 4600.723956562617, 4675.4155730533685, 4758.833440829623, 4798.5441383068555, 5257.815976440883, 5294.152935530296, 5298.549623282064, 5304.602154838402, 5307.310049693515, 4823.807047718122, 4827.227643577081, 4830.227163653799, 4847.491013443538, 4851.46633870281, 4897.730624815669, 5096.23556466533, 5128.897422051613, 5151.6908985461, 5196.142636464941, 5042.9243561345875, 5071.644984851173, 5074.82238121664, 5087.389513258433, 5087.949120508748, 4787.760611969318, 4800.823798169471, 4804.279358096313, 4823.397075365579, 4835.637327200544, 3504.4392897136336, 3676.889693309205, 3691.833867475916, 3693.5937046925355, 3722.1625134344554, 5137.743112844418, 5148.352527191412, 5174.534291913746, 5191.792328306826, 5194.792208311776, 5028.0, 5028.673136246132, 5042.294078828893, 5045.536794329603, 5048.268001139888, 4936.703797772145, 4976.552110310089, 5002.649814512949, 5010.69935803853, 5025.773840177128, 4930.482299358516, 4943.184374578154, 4948.406191256928, 4952.826651067196, 4966.329545511309, 5025.422076461254, 5026.095302845377, 5064.797408103635, 5076.771545280545, 5078.9238161426865, 4781.521847815191, 4906.0, 4925.778339974638, 4937.629677774109, 4951.900961980812], "value": 3739.338339020727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.666168659528, 557.7127779193713, 563.4956713741202, 568.1988396361131, 586.7506309818332, 10386.948065259672, 11258.718532036703, 11261.380624065672, 11325.943370283147, 11339.716507087327, 10991.340519568832, 11408.144389170804, 11703.06375489961, 11767.35279559626, 11999.340036298001, 760.1068744225527, 779.9649015794274, 781.5701364249668, 782.6751897962339, 782.9138794732575, 491.51585688097197, 498.77305825849334, 748.3788455581854, 771.8687823070063, 781.0588241169377, 813.4021494201756, 814.450246083894, 814.5886327404652, 815.0260438775665, 815.388458656008, 813.0609146435876, 813.2152472863685, 814.0069115678863, 814.0678922633551, 814.633414963263, 369.3775987461137, 376.77958394339345, 568.1506148308264, 586.5307753796988, 593.9524838012992, 12373.319467429288, 12424.813627795591, 12446.377681115999, 12451.003919686404, 12458.688532786662, 12080.0, 12445.62663120108, 12560.685982850411, 12726.87273127266, 13168.0, 11080.833787493195, 11122.49948752308, 11160.776784464266, 11311.83032254517, 11323.150763692756, 4109.609587089251, 4166.708330416872, 4201.495820501529, 4242.575742425764, 4398.670099742532, 60896.39103608952, 61372.38627613711, 61851.0, 62260.68869655668, 62397.0, 9851.359661621971, 10118.241131915136, 10155.847662285072, 10191.388516689023, 10417.687469375931, 15479.5356139316, 15486.922565387102, 15506.0, 15509.224538773016, 15520.844791552166, 5915.585908986416, 6041.0, 6093.817185484442, 6204.689765511706, 6236.563440559117, 3456.723462123024, 3523.0839981604454, 3524.9118772030906, 3552.484889691032, 3581.8925432237074, 2670.9866450667623, 2769.1692492252246, 2773.3482631581564, 2774.029089818547, 2775.320046588599, 478.4569513602087, 482.30788818046216, 483.2799129297322, 485.87367284506286, 494.71553856532637, 442.31882900333767, 457.6887716352845, 470.3532642616402, 479.8374104642215, 492.6452953873206, 6954.200266969262, 7011.684474198673, 7197.89203161953, 7491.250874912575, 7547.811304717426, 472.34344261476576, 474.98100075997263, 497.12009742755123, 498.12081675842165, 529.4282175250797, 3129.342838003999, 3173.3494633600058, 3248.6264079631146, 3295.8516866740574, 3463.6016858061644, 57134.714326428104, 92590.53704731568, 97352.0, 107791.0, 107819.46090269655, 51211.0, 64841.67579162168, 72602.63698681473, 79921.0, 84791.66042596487, 46740.532594674296, 47453.76273118681, 52276.73861630668, 63909.0, 82894.58552707318, 8338.207870252316, 8616.827663446822, 8872.955635221782, 8923.107689231025, 8943.686970955985, 42578.36132458078, 43934.14428062166, 44272.0, 44836.551634483236, 45502.77248613736, 38707.80646096751, 39462.21075578415, 39558.40662390124, 53974.73012634912, 63584.3641563597, 12187.51249949992, 12192.451339689913, 12407.193532420364, 12604.810927835906, 12795.872041279468, 10973.451327433757, 11536.077113830706, 11826.053915686896, 12725.300108493751, 12872.485100595872, 11113.22207445471, 11691.649250522498, 11699.941500292443, 11765.941170294094, 11905.583304584645, 11417.1437142213, 12253.509859605516, 12582.496700132258, 12718.809217861924, 13366.897922691654, 10764.40795756241, 11252.0, 11319.037881780141, 11323.377214252965, 11331.376774277494, 9597.328187026842, 9788.755281118029, 9831.705048848546, 9992.700218993441, 10432.634857779942, 8917.331200160144, 8967.237784788365, 9075.636974521209, 9599.712008639752, 9675.419474831533], "value": 6123.996012035205, "unit": "score"}], "name": "dromaeo_css", "value": 6194.547738139066, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 131.0, 175.0, 126.0, 123.0, 124.0, 122.0, 161.0, 124.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 160.0, 161.0, 163.0, 164.0, 164.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 114.0, 76.0, 77.0, 77.0, 76.0, 115.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 84.0, 83.0, 84.0, 105.0, 89.0, 83.0, 113.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 84.0, 89.0, 84.0, 85.0, 89.0, 83.0, 83.0, 90.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 136.0, 133.0, 145.0, 143.0, 134.0, 136.0, 187.0, 133.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 172.0, 176.0, 172.0, 172.0, 170.0, 173.0, 171.0, 171.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 68.0, 74.0, 70.0, 70.0, 69.0, 70.0, 70.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1546.6000000000001, "alertThreshold": 2.0}]} 11:15:21 INFO - Return code: 0 11:15:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:15:21 INFO - # TBPL SUCCESS # 11:15:21 INFO - Running post-action listener: _resource_record_post_action 11:15:21 INFO - [mozharness: 2016-09-27 18:15:21.258392Z] Finished run-tests step (success) 11:15:21 INFO - Running post-run listener: _resource_record_post_run 11:15:21 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403820544; Read time: 16; Write time: 270092 11:15:21 INFO - TinderboxPrint: CPU usage
13.0% 11:15:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:15:21 INFO - TinderboxPrint: I/O write bytes / time
403,820,544 / 270,092 11:15:21 INFO - TinderboxPrint: CPU idle
8,340.5 (87.0%) 11:15:21 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 11:15:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:15:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110448640; Read time: 0; Write time: 59476 11:15:21 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293371904; Read time: 0; Write time: 210616 11:15:21 INFO - Running post-run listener: _upload_blobber_files 11:15:21 INFO - Blob upload gear active. 11:15:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:15:21 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 11:15:21 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'] 11:15:21 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 11:15:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:15:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:28 INFO - (blobuploader) - INFO - Done attempting. 11:15:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:15:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:29 INFO - (blobuploader) - INFO - Done attempting. 11:15:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:15:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:29 INFO - (blobuploader) - INFO - Done attempting. 11:15:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:15:29 INFO - Return code: 0 11:15:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:15:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:15:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3a654cb231a5714eff3eccf83a572be44a453b149989e9b86f59315f26f24275fdd6720c8ee613b4e82406dcecceff5b06ca8b134dd132c2bedaf008c54075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd31a48d0c2b57bae77fe80ff7bf3d1592d6c2a2891d8d0a1785c5b207d5f825df1602bea915805833753249e6ca59508f51a01c916d2f57370101ccddd2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e5d8c259e469adbd9e2d8765717ef4e038ec15e87ae669b7690fb687f34c2d1e97b7ec0e122789d022b0592501ddcbefd3e5b713876dc3ca224c9b686c52ed2"} 11:15:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:15:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:15:29 INFO - Contents: 11:15:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3a654cb231a5714eff3eccf83a572be44a453b149989e9b86f59315f26f24275fdd6720c8ee613b4e82406dcecceff5b06ca8b134dd132c2bedaf008c54075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd31a48d0c2b57bae77fe80ff7bf3d1592d6c2a2891d8d0a1785c5b207d5f825df1602bea915805833753249e6ca59508f51a01c916d2f57370101ccddd2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e5d8c259e469adbd9e2d8765717ef4e038ec15e87ae669b7690fb687f34c2d1e97b7ec0e122789d022b0592501ddcbefd3e5b713876dc3ca224c9b686c52ed2"} 11:15:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:15:29 INFO - Copying logs to upload dir... 11:15:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:15:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.804182 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-27 11:15:29.538031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 11:15:29.542290) ========= 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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 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/9e3a654cb231a5714eff3eccf83a572be44a453b149989e9b86f59315f26f24275fdd6720c8ee613b4e82406dcecceff5b06ca8b134dd132c2bedaf008c54075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd31a48d0c2b57bae77fe80ff7bf3d1592d6c2a2891d8d0a1785c5b207d5f825df1602bea915805833753249e6ca59508f51a01c916d2f57370101ccddd2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e5d8c259e469adbd9e2d8765717ef4e038ec15e87ae669b7690fb687f34c2d1e97b7ec0e122789d022b0592501ddcbefd3e5b713876dc3ca224c9b686c52ed2"} build_url:https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/fW6bYy9_SOykKqNl3UmrYQ/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/9e3a654cb231a5714eff3eccf83a572be44a453b149989e9b86f59315f26f24275fdd6720c8ee613b4e82406dcecceff5b06ca8b134dd132c2bedaf008c54075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd31a48d0c2b57bae77fe80ff7bf3d1592d6c2a2891d8d0a1785c5b207d5f825df1602bea915805833753249e6ca59508f51a01c916d2f57370101ccddd2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e5d8c259e469adbd9e2d8765717ef4e038ec15e87ae669b7690fb687f34c2d1e97b7ec0e122789d022b0592501ddcbefd3e5b713876dc3ca224c9b686c52ed2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 11:15:29.568420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 11:15:29.568804) ========= 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=1f5564757af27664ca02d71f000001b0-1474996450.448215-1876653090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 11:15:29.651727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 11:15:29.652042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 11:15:29.652346) ========= ========= Total master_lag: 0.17 =========