builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1481038682.15 results: success (0) buildid: 20161206064938 builduid: 40557a0b34664e168ac91695244d19e6 revision: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.148392) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.149132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.149452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.164413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.164813) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-06 07:38:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-12-06 07:38:02 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.288642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.288994) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021158 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.338498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.338876) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 --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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-06 07:38:02,806 truncating revision to first 12 chars 2016-12-06 07:38:02,806 Setting DEBUG logging. 2016-12-06 07:38:02,807 attempt 1/10 2016-12-06 07:38:02,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ec83fde43f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-06 07:38:03,111 unpacking tar archive at: mozilla-central-3ec83fde43f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.967917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.968263) ========= script_repo_revision: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.968748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.969065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:38:02.979646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-06 07:38:02.979981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:03 INFO - MultiFileLogger online at 20161206 07:38:03 in /builds/slave/test 07:38:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:38:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:03 INFO - {'append_to_log': False, 07:38:03 INFO - 'base_work_dir': '/builds/slave/test', 07:38:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:38:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:03 INFO - 'branch': 'Firefox-Non-PGO', 07:38:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:03 INFO - 'config_files': ('talos/linux_config.py',), 07:38:03 INFO - 'default_actions': ('clobber', 07:38:03 INFO - 'read-buildbot-config', 07:38:03 INFO - 'download-and-extract', 07:38:03 INFO - 'populate-webroot', 07:38:03 INFO - 'create-virtualenv', 07:38:03 INFO - 'install', 07:38:03 INFO - 'run-tests'), 07:38:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:03 INFO - 'download_minidump_stackwalk': True, 07:38:03 INFO - 'download_symbols': 'ondemand', 07:38:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:03 INFO - 'installer_path': 'installer.exe', 07:38:03 INFO - 'log_level': 'info', 07:38:03 INFO - 'log_name': 'talos', 07:38:03 INFO - 'log_to_console': True, 07:38:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:03 INFO - 'opt_config_files': (), 07:38:03 INFO - 'pip_index': False, 07:38:03 INFO - 'sps_profile': False, 07:38:03 INFO - 'sps_profile_interval': 0, 07:38:03 INFO - 'suite': 'dromaeojs', 07:38:03 INFO - 'system_bits': '32', 07:38:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:03 INFO - 'title': 'talos-linux64-ix-002', 07:38:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:03 INFO - 'use_talos_json': True, 07:38:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:03 INFO - 'work_dir': 'build'} 07:38:03 INFO - [mozharness: 2016-12-06 15:38:03.539659Z] Running clobber step. 07:38:03 INFO - Running pre-action listener: _resource_record_pre_action 07:38:03 INFO - Running main action method: clobber 07:38:03 INFO - rmtree: /builds/slave/test/build 07:38:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:03 INFO - Running post-action listener: _resource_record_post_action 07:38:03 INFO - [mozharness: 2016-12-06 15:38:03.999301Z] Finished clobber step (success) 07:38:03 INFO - [mozharness: 2016-12-06 15:38:03.999413Z] Running read-buildbot-config step. 07:38:03 INFO - Running pre-action listener: _resource_record_pre_action 07:38:03 INFO - Running main action method: read_buildbot_config 07:38:03 INFO - Using buildbot properties: 07:38:04 INFO - { 07:38:04 INFO - "project": "", 07:38:04 INFO - "product": "firefox", 07:38:04 INFO - "script_repo_revision": "production", 07:38:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:38:04 INFO - "repository": "", 07:38:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:38:04 INFO - "buildid": "20161206064938", 07:38:04 INFO - "pgo_build": "False", 07:38:04 INFO - "basedir": "/builds/slave/test", 07:38:04 INFO - "buildnumber": 328, 07:38:04 INFO - "slavename": "talos-linux64-ix-002", 07:38:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:38:04 INFO - "platform": "ubuntu64_hw", 07:38:04 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:38:04 INFO - "branch": "mozilla-central", 07:38:04 INFO - "repo_path": "mozilla-central", 07:38:04 INFO - "revision": "3ec83fde43f2e1ba1dc583df0c722033c63ab7b7", 07:38:04 INFO - "stage_platform": "linux64", 07:38:04 INFO - "builduid": "40557a0b34664e168ac91695244d19e6", 07:38:04 INFO - "slavebuilddir": "test" 07:38:04 INFO - } 07:38:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:38:04 INFO - Running post-action listener: _resource_record_post_action 07:38:04 INFO - [mozharness: 2016-12-06 15:38:04.001850Z] Finished read-buildbot-config step (success) 07:38:04 INFO - [mozharness: 2016-12-06 15:38:04.001939Z] Running download-and-extract step. 07:38:04 INFO - Running pre-action listener: _resource_record_pre_action 07:38:04 INFO - Running main action method: download_and_extract 07:38:04 INFO - mkdir: /builds/slave/test/build/tests 07:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:04 INFO - trying https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:04 INFO - Downloading https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:38:04 INFO - Downloaded 1361 bytes. 07:38:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:04 INFO - Using the following test package requirements: 07:38:04 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:04 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:04 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:38:04 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'jsshell-linux-x86_64.zip'], 07:38:04 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:04 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:04 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:38:04 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:38:04 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:04 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:38:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:04 INFO - Fetch https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:05 INFO - Expected file size: 20218591 07:38:05 INFO - Obtained file size: 20218591 07:38:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:38:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:38:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:09 INFO - Fetch https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:10 INFO - Expected file size: 20218591 07:38:10 INFO - Obtained file size: 20218591 07:38:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:38:14 INFO - Fetch https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:38:15 INFO - Expected file size: 14409734 07:38:15 INFO - Obtained file size: 14409734 07:38:15 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')]} 07:38:15 INFO - trying https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:15 INFO - Downloading https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:17 INFO - Downloaded 55707020 bytes. 07:38:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:17 INFO - mkdir: /builds/slave/test/properties 07:38:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:17 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:17 INFO - Contents: 07:38:17 INFO - build_url:https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:18 INFO - Running post-action listener: _resource_record_post_action 07:38:18 INFO - Running post-action listener: set_extra_try_arguments 07:38:18 INFO - [mozharness: 2016-12-06 15:38:18.026425Z] Finished download-and-extract step (success) 07:38:18 INFO - [mozharness: 2016-12-06 15:38:18.026723Z] Running populate-webroot step. 07:38:18 INFO - Running pre-action listener: _resource_record_pre_action 07:38:18 INFO - Running main action method: populate_webroot 07:38:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:18 INFO - '--tppagecycles', 07:38:18 INFO - '7'], 07:38:18 INFO - 'tests': ['tsvgm']}}, 07:38:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['damp', 'tps']}, 07:38:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'tests': ['damp', 'tps']}, 07:38:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['dromaeo_dom']}, 07:38:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['basic_compositor_video']}, 07:38:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['a11yr', 07:38:18 INFO - 'ts_paint', 07:38:18 INFO - 'tpaint', 07:38:18 INFO - 'sessionrestore', 07:38:18 INFO - 'sessionrestore_no_auto_restore', 07:38:18 INFO - 'tabpaint']}, 07:38:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['tsvgx', 07:38:18 INFO - 'tsvgr_opacity', 07:38:18 INFO - 'tart', 07:38:18 INFO - 'tscrollx', 07:38:18 INFO - 'cart', 07:38:18 INFO - 'tsvg_static']}, 07:38:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:18 INFO - 'tsvgr_opacity', 07:38:18 INFO - 'tart', 07:38:18 INFO - 'tscrollx', 07:38:18 INFO - 'cart', 07:38:18 INFO - 'tsvg_static']}, 07:38:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'talos_options': ['--disable-e10s'], 07:38:18 INFO - 'tests': ['tp5o']}, 07:38:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:38:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'talos_options': ['--disable-e10s', 07:38:18 INFO - '--xperf_path', 07:38:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:18 INFO - 'tests': ['tp5n']}, 07:38:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:38:18 INFO - 'talos_options': ['--xperf_path', 07:38:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:18 INFO - 'tests': ['tp5n']}}, 07:38:18 INFO - 'talos.zip': {'path': '', 07:38:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:18 INFO - Running post-action listener: _resource_record_post_action 07:38:18 INFO - [mozharness: 2016-12-06 15:38:18.044525Z] Finished populate-webroot step (success) 07:38:18 INFO - [mozharness: 2016-12-06 15:38:18.044618Z] Running create-virtualenv step. 07:38:18 INFO - Running pre-action listener: _resource_record_pre_action 07:38:18 INFO - Running main action method: create_virtualenv 07:38:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:18 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 07:38:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:18 INFO - Using real prefix '/usr' 07:38:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:20 INFO - Installing pip.................done. 07:38:20 INFO - Return code: 0 07:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:20 INFO - Reading from file tmpfile_stdout 07:38:20 INFO - Output received: 07:38:20 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) 07:38:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:20 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:20 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 07:38:20 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 07:38:20 INFO - Using env: {'DISPLAY': ':0', 07:38:20 INFO - 'HOME': '/home/cltbld', 07:38:20 INFO - 'LANG': 'en_US.UTF-8', 07:38:20 INFO - 'LANGUAGE': 'en_US:en', 07:38:20 INFO - 'LOGNAME': 'cltbld', 07:38:20 INFO - 'MAIL': '/var/mail/cltbld', 07:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:20 INFO - 'MOZ_NO_REMOTE': '1', 07:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:20 INFO - 'NO_EM_RESTART': '1', 07:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:20 INFO - 'PWD': '/builds/slave/test', 07:38:20 INFO - 'SHELL': '/bin/bash', 07:38:20 INFO - 'SHLVL': '1', 07:38:20 INFO - 'TERM': 'linux', 07:38:20 INFO - 'TMOUT': '86400', 07:38:20 INFO - 'USER': 'cltbld', 07:38:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:20 INFO - '_': '/tools/buildbot/bin/python'} 07:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:21 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 07:38:21 INFO - Cleaning up... 07:38:21 INFO - Return code: 0 07:38:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:21 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')]} 07:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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')]} 07:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:21 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 07:38:21 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 07:38:21 INFO - Using env: {'DISPLAY': ':0', 07:38:21 INFO - 'HOME': '/home/cltbld', 07:38:21 INFO - 'LANG': 'en_US.UTF-8', 07:38:21 INFO - 'LANGUAGE': 'en_US:en', 07:38:21 INFO - 'LOGNAME': 'cltbld', 07:38:21 INFO - 'MAIL': '/var/mail/cltbld', 07:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:21 INFO - 'MOZ_NO_REMOTE': '1', 07:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:21 INFO - 'NO_EM_RESTART': '1', 07:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:21 INFO - 'PWD': '/builds/slave/test', 07:38:21 INFO - 'SHELL': '/bin/bash', 07:38:21 INFO - 'SHLVL': '1', 07:38:21 INFO - 'TERM': 'linux', 07:38:21 INFO - 'TMOUT': '86400', 07:38:21 INFO - 'USER': 'cltbld', 07:38:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:21 INFO - '_': '/tools/buildbot/bin/python'} 07:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:21 INFO - Downloading/unpacking psutil>=3.1.1 07:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:23 INFO - Installing collected packages: psutil 07:38:23 INFO - Running setup.py install for psutil 07:38:23 INFO - building 'psutil._psutil_linux' extension 07:38:23 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 07:38:23 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 07:38:23 INFO - building 'psutil._psutil_posix' extension 07:38:23 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 07:38:23 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 07:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:23 INFO - Successfully installed psutil 07:38:23 INFO - Cleaning up... 07:38:23 INFO - Return code: 0 07:38:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:38:23 INFO - Using env: {'DISPLAY': ':0', 07:38:23 INFO - 'HOME': '/home/cltbld', 07:38:23 INFO - 'LANG': 'en_US.UTF-8', 07:38:23 INFO - 'LANGUAGE': 'en_US:en', 07:38:23 INFO - 'LOGNAME': 'cltbld', 07:38:23 INFO - 'MAIL': '/var/mail/cltbld', 07:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:23 INFO - 'MOZ_NO_REMOTE': '1', 07:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:23 INFO - 'NO_EM_RESTART': '1', 07:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:23 INFO - 'PWD': '/builds/slave/test', 07:38:23 INFO - 'SHELL': '/bin/bash', 07:38:23 INFO - 'SHLVL': '1', 07:38:23 INFO - 'TERM': 'linux', 07:38:23 INFO - 'TMOUT': '86400', 07:38:23 INFO - 'USER': 'cltbld', 07:38:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:23 INFO - '_': '/tools/buildbot/bin/python'} 07:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:24 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 07:38:24 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 07:38:24 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 07:38:24 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 07:38:24 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 07:38:24 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 07:38:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:26 INFO - Installing collected packages: mozsystemmonitor 07:38:26 INFO - Running setup.py install for mozsystemmonitor 07:38:26 INFO - Successfully installed mozsystemmonitor 07:38:26 INFO - Cleaning up... 07:38:26 INFO - Return code: 0 07:38:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:26 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')]} 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:26 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')]} 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:26 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:26 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 07:38:26 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 07:38:26 INFO - Using env: {'DISPLAY': ':0', 07:38:26 INFO - 'HOME': '/home/cltbld', 07:38:26 INFO - 'LANG': 'en_US.UTF-8', 07:38:26 INFO - 'LANGUAGE': 'en_US:en', 07:38:26 INFO - 'LOGNAME': 'cltbld', 07:38:26 INFO - 'MAIL': '/var/mail/cltbld', 07:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:26 INFO - 'MOZ_NO_REMOTE': '1', 07:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:26 INFO - 'NO_EM_RESTART': '1', 07:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:26 INFO - 'PWD': '/builds/slave/test', 07:38:26 INFO - 'SHELL': '/bin/bash', 07:38:26 INFO - 'SHLVL': '1', 07:38:26 INFO - 'TERM': 'linux', 07:38:26 INFO - 'TMOUT': '86400', 07:38:26 INFO - 'USER': 'cltbld', 07:38:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:26 INFO - '_': '/tools/buildbot/bin/python'} 07:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:26 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:28 INFO - warning: no files found matching '*.txt' 07:38:28 INFO - no previously-included directories found matching 'build' 07:38:28 INFO - no previously-included directories found matching 'dist' 07:38:28 INFO - no previously-included directories found matching '.git*' 07:38:28 INFO - Installing collected packages: jsonschema, functools32 07:38:28 INFO - Running setup.py install for functools32 07:38:28 INFO - warning: no files found matching '*.txt' 07:38:28 INFO - no previously-included directories found matching 'build' 07:38:28 INFO - no previously-included directories found matching 'dist' 07:38:28 INFO - no previously-included directories found matching '.git*' 07:38:28 INFO - Successfully installed jsonschema functools32 07:38:28 INFO - Cleaning up... 07:38:28 INFO - Return code: 0 07:38:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:28 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')]} 07:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 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')]} 07:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:28 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 07:38:28 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 07:38:28 INFO - Using env: {'DISPLAY': ':0', 07:38:28 INFO - 'HOME': '/home/cltbld', 07:38:28 INFO - 'LANG': 'en_US.UTF-8', 07:38:28 INFO - 'LANGUAGE': 'en_US:en', 07:38:28 INFO - 'LOGNAME': 'cltbld', 07:38:28 INFO - 'MAIL': '/var/mail/cltbld', 07:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:28 INFO - 'MOZ_NO_REMOTE': '1', 07:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:28 INFO - 'NO_EM_RESTART': '1', 07:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:28 INFO - 'PWD': '/builds/slave/test', 07:38:28 INFO - 'SHELL': '/bin/bash', 07:38:28 INFO - 'SHLVL': '1', 07:38:28 INFO - 'TERM': 'linux', 07:38:28 INFO - 'TMOUT': '86400', 07:38:28 INFO - 'USER': 'cltbld', 07:38:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:28 INFO - '_': '/tools/buildbot/bin/python'} 07:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:29 INFO - Cleaning up... 07:38:29 INFO - Return code: 0 07:38:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:29 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')]} 07:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:29 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')]} 07:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:29 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:29 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 07:38:29 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 07:38:29 INFO - Using env: {'DISPLAY': ':0', 07:38:29 INFO - 'HOME': '/home/cltbld', 07:38:29 INFO - 'LANG': 'en_US.UTF-8', 07:38:29 INFO - 'LANGUAGE': 'en_US:en', 07:38:29 INFO - 'LOGNAME': 'cltbld', 07:38:29 INFO - 'MAIL': '/var/mail/cltbld', 07:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:29 INFO - 'MOZ_NO_REMOTE': '1', 07:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:29 INFO - 'NO_EM_RESTART': '1', 07:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:29 INFO - 'PWD': '/builds/slave/test', 07:38:29 INFO - 'SHELL': '/bin/bash', 07:38:29 INFO - 'SHLVL': '1', 07:38:29 INFO - 'TERM': 'linux', 07:38:29 INFO - 'TMOUT': '86400', 07:38:29 INFO - 'USER': 'cltbld', 07:38:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:29 INFO - '_': '/tools/buildbot/bin/python'} 07:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:32 INFO - Downloading docopt-0.6.1.tar.gz 07:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:32 INFO - Running setup.py install for blobuploader 07:38:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:32 INFO - Running setup.py install for requests 07:38:32 INFO - Running setup.py install for docopt 07:38:32 INFO - Successfully installed blobuploader requests docopt 07:38:32 INFO - Cleaning up... 07:38:32 INFO - Return code: 0 07:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:32 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:32 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 07:38:32 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 07:38:32 INFO - Using env: {'DISPLAY': ':0', 07:38:32 INFO - 'HOME': '/home/cltbld', 07:38:32 INFO - 'LANG': 'en_US.UTF-8', 07:38:32 INFO - 'LANGUAGE': 'en_US:en', 07:38:32 INFO - 'LOGNAME': 'cltbld', 07:38:32 INFO - 'MAIL': '/var/mail/cltbld', 07:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:32 INFO - 'MOZ_NO_REMOTE': '1', 07:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:32 INFO - 'NO_EM_RESTART': '1', 07:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:32 INFO - 'PWD': '/builds/slave/test', 07:38:32 INFO - 'SHELL': '/bin/bash', 07:38:32 INFO - 'SHLVL': '1', 07:38:32 INFO - 'TERM': 'linux', 07:38:32 INFO - 'TMOUT': '86400', 07:38:32 INFO - 'USER': 'cltbld', 07:38:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:32 INFO - '_': '/tools/buildbot/bin/python'} 07:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:33 INFO - Running setup.py (path:/tmp/pip-GNbFec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:33 INFO - Running setup.py (path:/tmp/pip-5PRBjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:33 INFO - Running setup.py (path:/tmp/pip-dRYwK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:33 INFO - Running setup.py (path:/tmp/pip-1AO_el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:33 INFO - Running setup.py (path:/tmp/pip-2UmGND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:33 INFO - Running setup.py (path:/tmp/pip-4CkhZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:33 INFO - Running setup.py (path:/tmp/pip-X2P1Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:33 INFO - Running setup.py (path:/tmp/pip-00jFNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:33 INFO - Running setup.py (path:/tmp/pip-VsZ6mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:33 INFO - Running setup.py (path:/tmp/pip-zRTBpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:33 INFO - Running setup.py (path:/tmp/pip-Dbi5_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:33 INFO - Running setup.py (path:/tmp/pip-YttPMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:33 INFO - Running setup.py (path:/tmp/pip-NK4pPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:33 INFO - Running setup.py (path:/tmp/pip-if5AZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:34 INFO - Running setup.py (path:/tmp/pip-j4ClNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:34 INFO - Running setup.py (path:/tmp/pip-3D3JUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:34 INFO - Running setup.py (path:/tmp/pip-0dyZAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:34 INFO - Running setup.py install for manifestparser 07:38:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozcrash 07:38:34 INFO - Running setup.py install for mozdebug 07:38:34 INFO - Running setup.py install for mozdevice 07:38:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozfile 07:38:34 INFO - Running setup.py install for mozhttpd 07:38:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozinfo 07:38:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozInstall 07:38:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozleak 07:38:35 INFO - Running setup.py install for mozlog 07:38:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for moznetwork 07:38:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozprocess 07:38:35 INFO - Running setup.py install for mozprofile 07:38:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozrunner 07:38:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozscreenshot 07:38:35 INFO - Running setup.py install for moztest 07:38:35 INFO - Running setup.py install for mozversion 07:38:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:35 INFO - Cleaning up... 07:38:36 INFO - Return code: 0 07:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:36 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')]} 07:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:36 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')]} 07:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:36 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:36 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 07:38:36 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 07:38:36 INFO - Using env: {'DISPLAY': ':0', 07:38:36 INFO - 'HOME': '/home/cltbld', 07:38:36 INFO - 'LANG': 'en_US.UTF-8', 07:38:36 INFO - 'LANGUAGE': 'en_US:en', 07:38:36 INFO - 'LOGNAME': 'cltbld', 07:38:36 INFO - 'MAIL': '/var/mail/cltbld', 07:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:36 INFO - 'MOZ_NO_REMOTE': '1', 07:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:36 INFO - 'NO_EM_RESTART': '1', 07:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:36 INFO - 'PWD': '/builds/slave/test', 07:38:36 INFO - 'SHELL': '/bin/bash', 07:38:36 INFO - 'SHLVL': '1', 07:38:36 INFO - 'TERM': 'linux', 07:38:36 INFO - 'TMOUT': '86400', 07:38:36 INFO - 'USER': 'cltbld', 07:38:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:36 INFO - '_': '/tools/buildbot/bin/python'} 07:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:36 INFO - Running setup.py (path:/tmp/pip-4o4F9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:36 INFO - Running setup.py (path:/tmp/pip-rNG5XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:36 INFO - Running setup.py (path:/tmp/pip-o9Ci56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:36 INFO - Running setup.py (path:/tmp/pip-HpQqTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:36 INFO - Running setup.py (path:/tmp/pip-bHr5dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:36 INFO - Running setup.py (path:/tmp/pip-TUlgpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:36 INFO - Running setup.py (path:/tmp/pip-3H_O3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:36 INFO - Running setup.py (path:/tmp/pip-GQqXHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:36 INFO - Running setup.py (path:/tmp/pip-ZPpjnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:36 INFO - Running setup.py (path:/tmp/pip-hmqzEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:36 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)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:36 INFO - Running setup.py (path:/tmp/pip-eR5aYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:37 INFO - Running setup.py (path:/tmp/pip-9PR2ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:37 INFO - Running setup.py (path:/tmp/pip-z0ArMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:37 INFO - Running setup.py (path:/tmp/pip-6o4UGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:37 INFO - Running setup.py (path:/tmp/pip-Cdruwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:37 INFO - Running setup.py (path:/tmp/pip-l52cOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:37 INFO - Running setup.py (path:/tmp/pip-HskOrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:37 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)) 07:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:37 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)) 07:38:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:39 INFO - Downloading blessings-1.6.tar.gz 07:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:39 INFO - Installing collected packages: blessings 07:38:39 INFO - Running setup.py install for blessings 07:38:39 INFO - Successfully installed blessings 07:38:39 INFO - Cleaning up... 07:38:39 INFO - Return code: 0 07:38:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:39 INFO - Reading from file tmpfile_stdout 07:38:39 INFO - Current package versions: 07:38:39 INFO - argparse == 1.2.1 07:38:39 INFO - blessings == 1.6 07:38:39 INFO - blobuploader == 1.2.4 07:38:39 INFO - docopt == 0.6.1 07:38:39 INFO - functools32 == 3.2.3-2 07:38:39 INFO - jsonschema == 2.5.1 07:38:39 INFO - manifestparser == 1.1 07:38:39 INFO - mozInstall == 1.12 07:38:39 INFO - mozcrash == 1.0 07:38:39 INFO - mozdebug == 0.1 07:38:39 INFO - mozdevice == 0.49 07:38:39 INFO - mozfile == 1.2 07:38:39 INFO - mozhttpd == 0.7 07:38:39 INFO - mozinfo == 0.9 07:38:39 INFO - mozleak == 0.1 07:38:39 INFO - mozlog == 3.4 07:38:39 INFO - moznetwork == 0.27 07:38:39 INFO - mozprocess == 0.23 07:38:39 INFO - mozprofile == 0.28 07:38:39 INFO - mozrunner == 6.13 07:38:39 INFO - mozscreenshot == 0.1 07:38:39 INFO - mozsystemmonitor == 0.3 07:38:39 INFO - moztest == 0.7 07:38:39 INFO - mozversion == 1.4 07:38:39 INFO - psutil == 3.1.1 07:38:39 INFO - requests == 1.2.3 07:38:39 INFO - wsgiref == 0.1.2 07:38:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:39 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')]} 07:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:39 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')]} 07:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:39 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:39 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 07:38:39 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 07:38:39 INFO - Using env: {'DISPLAY': ':0', 07:38:39 INFO - 'HOME': '/home/cltbld', 07:38:39 INFO - 'LANG': 'en_US.UTF-8', 07:38:39 INFO - 'LANGUAGE': 'en_US:en', 07:38:39 INFO - 'LOGNAME': 'cltbld', 07:38:39 INFO - 'MAIL': '/var/mail/cltbld', 07:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:39 INFO - 'MOZ_NO_REMOTE': '1', 07:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:39 INFO - 'NO_EM_RESTART': '1', 07:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:39 INFO - 'PWD': '/builds/slave/test', 07:38:39 INFO - 'SHELL': '/bin/bash', 07:38:39 INFO - 'SHLVL': '1', 07:38:39 INFO - 'TERM': 'linux', 07:38:39 INFO - 'TMOUT': '86400', 07:38:39 INFO - 'USER': 'cltbld', 07:38:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:39 INFO - '_': '/tools/buildbot/bin/python'} 07:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 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)) 07:38:40 INFO - Cleaning up... 07:38:40 INFO - Return code: 0 07:38:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:40 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 0x7f21acf75e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', '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 07:38:40 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 07:38:40 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 07:38:40 INFO - Using env: {'DISPLAY': ':0', 07:38:40 INFO - 'HOME': '/home/cltbld', 07:38:40 INFO - 'LANG': 'en_US.UTF-8', 07:38:40 INFO - 'LANGUAGE': 'en_US:en', 07:38:40 INFO - 'LOGNAME': 'cltbld', 07:38:40 INFO - 'MAIL': '/var/mail/cltbld', 07:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:40 INFO - 'MOZ_NO_REMOTE': '1', 07:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:40 INFO - 'NO_EM_RESTART': '1', 07:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:40 INFO - 'PWD': '/builds/slave/test', 07:38:40 INFO - 'SHELL': '/bin/bash', 07:38:40 INFO - 'SHLVL': '1', 07:38:40 INFO - 'TERM': 'linux', 07:38:40 INFO - 'TMOUT': '86400', 07:38:40 INFO - 'USER': 'cltbld', 07:38:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:40 INFO - '_': '/tools/buildbot/bin/python'} 07:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:40 INFO - Cleaning up... 07:38:40 INFO - Return code: 0 07:38:40 INFO - Running post-action listener: _resource_record_post_action 07:38:40 INFO - Running post-action listener: _start_resource_monitoring 07:38:40 INFO - Starting resource monitoring. 07:38:40 INFO - [mozharness: 2016-12-06 15:38:40.426617Z] Finished create-virtualenv step (success) 07:38:40 INFO - [mozharness: 2016-12-06 15:38:40.427122Z] Running install step. 07:38:40 INFO - Running pre-action listener: _resource_record_pre_action 07:38:40 INFO - Running main action method: install 07:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:40 INFO - Reading from file tmpfile_stdout 07:38:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:40 INFO - Reading from file tmpfile_stdout 07:38:40 INFO - Output received: 07:38:40 INFO - Usage: mozinstall [options] installer 07:38:40 INFO - Options: 07:38:40 INFO - -h, --help show this help message and exit 07:38:40 INFO - -d DEST, --destination=DEST 07:38:40 INFO - Directory to install application into. [default: 07:38:40 INFO - "/builds/slave/test"] 07:38:40 INFO - --app=APP Application being installed. [default: firefox] 07:38:40 INFO - mkdir: /builds/slave/test/build/application 07:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:56 INFO - Reading from file tmpfile_stdout 07:38:56 INFO - Output received: 07:38:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:56 INFO - Running post-action listener: _resource_record_post_action 07:38:56 INFO - [mozharness: 2016-12-06 15:38:56.756989Z] Finished install step (success) 07:38:56 INFO - [mozharness: 2016-12-06 15:38:56.757232Z] Running run-tests step. 07:38:56 INFO - Running pre-action listener: _resource_record_pre_action 07:38:56 INFO - Running main action method: run_tests 07:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:56 INFO - Python 2.7.3 07:38:56 INFO - Return code: 0 07:38:56 INFO - grabbing minidump binary from tooltool 07:38:56 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')]} 07:38:56 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 0x20d1f20>, '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 0x203ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:56 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 07:38:56 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 07:38:56 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 07:38:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:56 INFO - Return code: 0 07:38:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 07:38:56 INFO - Using env: {'DISPLAY': ':0', 07:38:56 INFO - 'HOME': '/home/cltbld', 07:38:56 INFO - 'LANG': 'en_US.UTF-8', 07:38:56 INFO - 'LANGUAGE': 'en_US:en', 07:38:56 INFO - 'LOGNAME': 'cltbld', 07:38:56 INFO - 'MAIL': '/var/mail/cltbld', 07:38:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:56 INFO - 'MOZ_NO_REMOTE': '1', 07:38:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:56 INFO - 'NO_EM_RESTART': '1', 07:38:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:56 INFO - 'PWD': '/builds/slave/test', 07:38:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:56 INFO - 'SHELL': '/bin/bash', 07:38:56 INFO - 'SHLVL': '1', 07:38:56 INFO - 'TERM': 'linux', 07:38:56 INFO - 'TMOUT': '86400', 07:38:56 INFO - 'USER': 'cltbld', 07:38:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931', 07:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:56 INFO - '_': '/tools/buildbot/bin/python'} 07:38:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:38:57 INFO - mozversion application_buildid: 20161206064938 07:38:57 INFO - mozversion application_changeset: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 07:38:57 INFO - mozversion application_display_name: Nightly 07:38:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:57 INFO - mozversion application_name: Firefox 07:38:57 INFO - mozversion application_remotingname: firefox 07:38:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:57 INFO - mozversion application_vendor: Mozilla 07:38:57 INFO - mozversion application_version: 53.0a1 07:38:57 INFO - mozversion platform_buildid: 20161206064938 07:38:57 INFO - mozversion platform_changeset: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 07:38:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:57 INFO - mozversion platform_version: 53.0a1 07:38:57 INFO - using testdate: 1481038737 07:38:57 INFO - actual date: 1481038737 07:38:57 INFO - starting webserver on 'localhost:34775' 07:38:57 INFO - SUITE-START | Running 2 tests 07:38:57 INFO - TEST-START | dromaeo_css 07:38:57 INFO - operating with platform_type : linux_ 07:38:57 INFO - Initialising browser for dromaeo_css test... 07:38:57 INFO - TEST-INFO | started process 28513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJg7wE9/profile http://localhost:34775/getInfo.html) 07:39:01 INFO - PROCESS | 28513 | __metrics Screen width/height:1600/1200 07:39:01 INFO - PROCESS | 28513 | colorDepth:24 07:39:01 INFO - PROCESS | 28513 | Browser inner width/height: 1024/697 07:39:01 INFO - PROCESS | 28513 | __metrics 07:39:02 INFO - PROCESS | 28513 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:39:02 INFO - PROCESS | 28513 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:02 INFO - PROCESS | 28513 | console.error: PushService: 07:39:02 INFO - PROCESS | 28513 | stateChangeProcessEnqueue: Error transitioning state 07:39:02 INFO - PROCESS | 28513 | UnknownError 07:39:03 INFO - TEST-INFO | 28513: exit 0 07:39:03 INFO - Browser initialized. 07:39:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:03 INFO - TEST-INFO | started process 28593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJg7wE9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:15 INFO - PROCESS | 28593 | RSS: Main: 174297088 07:39:15 INFO - PROCESS | 28593 | 07:40:07 INFO - PROCESS | 28593 | 1481038807056 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] 07:42:21 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34775/tests/dromaeo/cssquery-ext.html) 07:42:23 INFO - PROCESS | 28593 | RSS: Main: 308215808 07:42:23 INFO - PROCESS | 28593 | 07:45:25 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-ext.html (next: http://localhost:34775/tests/dromaeo/cssquery-jquery.html) 07:45:26 INFO - PROCESS | 28593 | RSS: Main: 285204480 07:45:26 INFO - PROCESS | 28593 | 07:48:28 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34775/tests/dromaeo/cssquery-mootools.html) 07:48:29 INFO - PROCESS | 28593 | RSS: Main: 247582720 07:48:29 INFO - PROCESS | 28593 | 07:51:31 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34775/tests/dromaeo/cssquery-prototype.html) 07:51:32 INFO - PROCESS | 28593 | RSS: Main: 225222656 07:51:32 INFO - PROCESS | 28593 | 07:54:35 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34775/tests/dromaeo/cssquery-yui.html) 07:54:36 INFO - PROCESS | 28593 | RSS: Main: 225239040 07:54:36 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | Cycle 1(1): loaded http://localhost:34775/tests/dromaeo/cssquery-yui.html (next: http://localhost:34775/tests/dromaeo/cssquery-dojo.html) 07:57:39 INFO - PROCESS | 28593 | RSS: Main: 294027264 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | __start_tp_report 07:57:39 INFO - PROCESS | 28593 | _x_x_mozilla_page_load 07:57:39 INFO - PROCESS | 28593 | _x_x_mozilla_page_load_details 07:57:39 INFO - PROCESS | 28593 | |i|pagename|runs| 07:57:39 INFO - PROCESS | 28593 | |0;dojo.html;2600.4669042846217;2621.0826210826203;2646.232592548162;2658.0696756135353;2671.038426166581;4541.1598854212;4591.311303304497;4704.249402107973;4764.928526072112;4789.401324834395;4639.141758774621;4683.32091846682;4722.480527142012;4755.2153894607345;4818.759062046901;4287.635550978171;4308.526062133163;4347.826086956518;4379.912401751963;4455.8217671293105;4025.087329310891;4358.215521206182;4386.824527018915;4416.470023597173;4462.598366147046;4162.313218319004;4202.180574787918;4369.060651959812;4413.293872980308;4445.933311000337;4241.448611680493;4243.087736136715;4245.936310955338;4247.299195632717;4250.851220207278;4212.641925436342;4215;4215.873523794291;4227.767472788995;4232.703710740249;4583.793729282191;4675.859724208245;4687.789049492781;4741.8103275868925;4802.447718512381;5063.240513922941;5079.517445842639;5084.77118529667;5085.059264036166;5131.563817075553;5100.617453690951;5105.412877519096;5110;5114.923276150861;5116.616253780981;4629.143608432417;4669.972606026737;4679.953200467951;4688.413948256468;4779.3070004849105;5185.637005409585;5186.662866913639;5224.50367215114;5235.685858848481;5236.92144617831;4915.188993816052;4964.35463389757;4967.006598680278;4973.378327709036;5014.648974571818;4941.827036053721;5020.1214787412055;5023.14606516893;5023.271625614266;5064.34163558735;4912.968276661941;4944.728039957837;4945.060438516671;4949.331840201598;5009.824656137018;4976.253561965734;4977.8257760978195;4984.7258400788305;4986.925196122061;5022.673526220784;4252.29837076885;4255.446791917093;4261.2542805009;4295.72077814941;4297.247981603269;3669.5046168766876;3678.8712395066045;3699.389600715852;3707.2400157967554;3720.032791474236;4385.736855788663;4388.451443569554;4402.16358891816;4436.5785250401805;4445.288753799441;5093.465186155475;5099;5099.745012749348;5104.566111880532;5138.691678499302;4280.978595107004;4327.65378769704;4357.520672725997;4402.735835849795;4445.422095127613;4540.659450541222;4555.362249285103;4562.133194693064;4576.954230457719;4632.166210082218;4816.325714399917;4821.95178048215;4823.710577365369;4828.396450443694;4873.926891096708;5017.448080711192;5028.974855125847;5057.6459647824295;5091.363579552556;5110.693358398508;4681.391419115629;4725.314829349793;4725.716457012591;4736.123817093849;4811.037792441596;5023.120953833138;5024.171011783015;5027.69833809958;5066.290719299227;5074.416442109205;5051.318072060371;5087.821926232564;5089.720065396439;5093.617978651542;5143.099957507496;4827.300041494034;4874.147024270809;4874.683145595525;4943.826966056171;4946.08497427977;4894.045661096195;4941.308216849572;4943.0361079590575;4998.425181104074;5001.974990125026;4884.682495637772;4885.267209918541;4888.902221955612;4893.551311555345;4907.9263811043575;4979.352684151182;4984.42679091909;4987.576056035133;4990.8253211137435;5037.294778730908;4692.9530704692515;4783.4738178801;4788;4829.927551086666;4835 07:57:39 INFO - PROCESS | 28593 | |1;ext.html;559.6977632078678;561.8258339914629;568.0513542384218;568.8691600931788;570.3982298674898;27693.169204923834;37921.620783792154;39279.410808837856;39393.8030309848;42604.36093458601;39169.804150979275;39535;39616.405753913714;39678.801605992005;39701.40447893277;7281.271872812729;7541.321281084687;7662.616869156548;7687.077550693896;7689.807754806118;7287.708491660327;7534.8116297092465;7538.095428548582;9640;9907.752306192331;9847.359921605108;9853.211743060538;9905.851412228822;9907.702768916908;9920.45437500937;9777.657781977632;9827.557759900787;9840.06519380665;9841.45871977041;9844;9730.805383892282;9754.707358779247;9766.853497197548;9769.51152442375;9784.755381115458;36713.449298260544;37025.25949481022;37057.81471092627;37070.62929370699;37120;2928.3996780659913;3028.5911401960893;3107.6892310768967;3241.983790081058;3538.3630946429635;27545;27636.58545121825;27704.584431233547;27711.168664940084;28444.431111377657;3292.96707032929;3380.7633465657414;3395.3209358128224;3466.7746596471147;3498.1604414940484;253275;253859;254978;256048;256067;52796;53132;53317.200241996405;53349;53377.72645239994;56330.43669563334;56331.71834140885;56417.43582564204;56464.22429308427;56483.71758141183;13870.722585548434;14103.294835258195;14129.85870141306;14135.505257315945;14140.717185656229;10465.215108866865;10511.474426278655;10552.314099583657;10613.09788667972;10616.309939853885;14897.404103835725;15299.46451874179;16034.358625654842;16454.259558319904;16655.750163747554;6680.766173183915;6767.52627316093;6802.659867006729;6967.93032069683;7059.870420732658;738.6712912753773;818.9186100247947;853.9914600854037;866.5883705239961;940.9059094090536;26233.737662623513;27025.324366890985;27282;27826.86086569554;27829;909.1681111782777;994.8308787506141;995.8904520502739;1014.1734486393566;1018.2007124407453;13536;14628.853711462749;14641.853581464049;14752.778708319383;14927.701445971019;364581;369860;370333;370370;371718;31713.04860854178;31853.681463185072;31894.521582176287;31919.52120718191;31958.36083278368;1058.0636137018794;1079.2121751121724;1134.6142311614092;1163.3717792392013;1188.197966372695;25894.151643318844;27832.86083569569;28162.577561337006;28441.43117137687;28560.714392856637;39913.40129897996;40463.797681011405;40530;40606.59393406028;40657.18685626212;266347;267561;268335;268345;268548;24003.159889404487;24372.390690232885;24982.75017249877;25048.123315683864;26690.19929402121;39365;39618.60381396149;39737.40393894036;39828.39004067034;40463.393049104874;33591.49612755762;34197;34377.82811086029;34378.82810586031;34563.654363456044;33266;34107;34601.307973840885;34829.825850870584;35036.299274014884;34306.48540271948;34358.82820585981;34484.48273275853;34660.133496662784;34762.478562822085;28159.43681126325;28795.712042879302;32013.359732804747;32409.67590324161;32485.02544923656;24220;24444.755552444247;24594.139205127736;24824.627630585917;24902.501949960537 07:57:39 INFO - PROCESS | 28593 | |2;jquery.html;354.36922278344554;371.11859334081555;377.48473333899227;378.7462400191871;399.670272025579;12293.569725059624;12434.937825310872;13064.542741004067;15534.68930621387;16308.103054332007;16603.50189494314;17138.485845424628;17200.913995430037;17250;17288.91355543224;4680.976595117028;5141.203113517392;5157.5358217760395;5175.948240517603;5176.404713457944;3693.150575367654;3856.5564960029533;5053.292539044537;5145.819896303611;5146.0222557714105;3857.614238576134;3865.323568375537;3940.389239667856;6018.097285407181;6112.266528016622;6034.818955431344;6103.816885493442;6104.962156433373;6115.021596544531;6120.479759220471;5239.947600524022;5304.071787437183;5362.51737343641;5363.678179309254;5364.8122315718765;19635.214591416327;19669.11488982999;19767.209311627517;19810.40568782939;19867.602647947104;1888.2730148892638;1893.8863668179954;1894.393793985925;1936.7094935759749;1960.725498430221;8579.828403431959;8769;8923.643054277822;9412.199963003153;9490.28822838283;1716.347787840625;1724.1982478147722;1736.4443378119006;1743.7384392341123;1757.4639734880857;59218.40781592215;60847.39152608462;66917.29323308247;68357;69900.65049674718;9126.817463650823;9264.629414823332;9368.531573421302;9839.311248212556;9840.3603765755;13160.473581056842;13169.407376668072;13180.209187448592;13185.208887466782;13207.141535800141;6618.106555615027;6777.423918966844;6873.20958089816;6873.931260687429;6945.40964018054;6133.785317513865;6150.292716337589;6239.78160764371;6536.3136870627895;6886.070380498569;3897.4543563901075;3967.6874683102387;4037.9394309085387;4039.1517781265675;4250.574942505787;1688.223417228089;1729.3169198166904;1803.4319189455541;1807.4939017074978;1815.3827698582545;763.5723994563062;818.5497976113234;843.5992903370973;865.6710450028949;884.1821315283337;15664.921675391777;15927.840721592636;16290.592735181715;16350.509484715478;16980.575485612713;788.2669117720575;808.8584497712877;819.4632515702106;822.407866336249;836.2975100915261;8848;8874.334424918157;9111.681091161778;9227.630894764134;9606.903930960601;343800;347115;347700;349764;351749;78209.60895195602;78593.21406785859;80678.59660701659;81212.18787812165;81691.18308816955;894.49461054504;898.9146031127033;900.8018235988203;915.7115508614766;921.6313474610209;13785.51750688721;14479.131252124906;14708.779368309699;14848.257587120384;15299.46451874179;35566;35838.10404739902;35857.82071089628;36074.27851443009;37260.81369593135;47332;48412;49106;49159.50840491549;51131.488685114164;6374.235091789015;6582.506312026521;6691.825156823954;7024.754133605504;7236.565806051653;10933.781324373309;11557.47991340375;11571.305721656727;11734.765304694029;12264.877351226374;9727.854082188915;9883;10244.846327304947;10559.736006599896;10595.735106622087;9802.313838031268;10166.627505286691;10398.896011040095;10483.21375896826;10594.735131621772;5083.898322033465;5232.947670523246;9787.265955053257;10400.687979360631;10641.882602326645;6792.320767923168;6829.385355318045;6945.895811562932;6977.825554361181;7196.9640151801;7313.305236002571;9225.261979041794;10040.64857729976;10119.544620491948;10235.897641023494 07:57:39 INFO - PROCESS | 28593 | |3;mootools.html;1237.6782036670463;1313.1595778701633;1352.6753579141005;1408.5703860322596;1656.1305314709784;6170.784022559212;6708.228553716324;6967.895481567781;6973.198082220546;7158.427325813936;6952.409045231148;7031.8945215821805;7037.331453511908;7038.507304488688;7041.225465198824;1807.6565452564037;1855.8422534084618;2046.232662751472;2076.688496725488;2078.5738923520717;2025.4025062606565;2081.4172031831113;2085.092984551725;2088.1751708075303;2090.8745475271458;2044.6421876171685;2047.119738512439;2050.28240115959;2055.321743824534;2055.856090073695;2022.7774944756138;2067.0491573876034;2071.906764195607;2072.336852207294;2075.5122546201783;2056.1775289884017;2087.5198704298095;2087.65553683642;2097.3078883968255;2108.5993661204475;7178.353948144692;7296.562206267641;7327.450441216877;7377.926220737778;7388.150362708304;4344.717593356421;4476.753778542179;4480.081583275453;4482.125985432842;4482.394876691637;2730.781537476997;2937.7209165129493;2983.4331477019296;3011.382666553351;3021.365513242222;861.7974775927652;901.2969883490888;919.3013309884469;921.230772305126;931.1237855720728;9474.905250947471;9536.046395360478;9536.952315238448;9544;9567.282453815991;3867.1105645701646;3958.1687845552183;4053.2096241232675;4059.6143366380147;4112.609302116294;8251.33989280856;8261.586920654063;8268.214519620748;8271.627776750061;8298.460600060977;4502.279635258343;4506.639468842484;4506.954930450719;4507.459104907432;4510.977445112753;3462.774919630216;3598.4062629666337;4100.958990410118;4104.56902025289;4107.260693075275;3346.397648423307;3428.6228514863346;3526.4785678240182;3546.4680297954997;3574.0528759878653;1147.5352482244705;1190.6428071578491;1193.8507686539183;1195.1454709882476;1195.1813008089487;793.9007624046994;797.5972134072256;842.6039761312173;854.6880388658095;856.3063918226256;4865.099956508057;4898.608111351084;4913.828016019422;4959.181735013754;5025.246213068069;386.1042381674544;391.35231192376665;392.22926948546245;410.8007616306089;413.12623800661385;3384.8476818543227;3409.8636054558037;3465.1856813648774;3529.5411596492804;3590.2998915211283;8460.746177614681;8675.349348798865;8731.956340218385;8744.606492707844;8758.91241087581;8698.173673501007;8708.08565100668;8724.214820666171;8745.825083498294;8758.781030474289;6672.899906501407;6749;6749.932500675029;6826.8634627308165;6836.418904393083;5014.42334131565;5019.071471777733;5022.347094877642;5032.0690672225755;5068.619853510928;7687.962125113038;7878.054633444023;7976.760697179094;7997.160298168608;8081.313088387553;7980.441369104107;8045;8102.878456823035;8191.017077950684;8200.58997050157;5525.502704756591;5577.498025177591;6220.440160385587;6350.523710721622;6363.077353783768;6486.2216534016225;6594.142761440982;6616.305287944889;6941.062956500808;6962.756303529352;6198.2252218472695;6312.873742525216;6337.429631333202;6421.5504914657395;6494.935050649433;6103.938960610337;6117.785877494266;6233.438990490878;6324.683765811783;6332.588381755171;5919.141724450017;6020.458158765732;6022.427869352405;6031.909521357271;6032.3967603239325;4345.174416860787;4415.27148020573;4430.889227769331;4461.821527139008;4510.909781804411;4280.293751530962;4289.6139347458875;4297.613214810682;4401.7799110043725;4402.581754733295 07:57:39 INFO - PROCESS | 28593 | |4;prototype.html;282.7073978432323;287.78991336324486;292.9663088744795;294.5508100147276;299.6075141564549;4580.221362368397;4671.532846715327;4748.240281554952;4794.904101917964;4799.856004319871;4540.3870477485525;4612.377329060576;4663.207254766689;4664.650151238662;4700.882477938053;3525.4006818840858;3612.277544491099;3717;3718.9070273243115;3728.310262601414;3634.582512820002;3730.7388482806214;3737.4954381158605;3737.8878633641034;3744.3634582121103;3701.1857391373856;3701.68535674468;3703.1112532992156;3712;3712.164762928333;3709.350863598859;3717.75834570752;3720.144366795625;3721.9441708374397;3722.4416337549314;3127.781055326128;3227.677232276777;3260.6576309487637;3293.6047674279002;3294.357600267949;4547.658925580595;4587.188060715998;4599.83900563482;4605.631549476034;4624.427694583824;4205.663546916239;4205.864416607529;4208.389783481378;4208.516974984774;4210.726302790309;4686.461056978423;4915.483874193194;4930.531599498042;4948.57937075349;4954.578860796837;3582.39099353108;3603.94594081089;3611.638836116367;3631.400818864884;3631.891043268706;5148.639595228336;5168.302279192299;5178.14560597501;5219.399769026611;5227.320448341729;3703.425968974759;3713.721470889694;3721.404575267944;3722.6091260417807;3726.8136593170234;3654.7025805838543;3715.888523344304;3746.775193488345;3765.755225910307;3768.1898391845884;4215.557366476537;4222.978885105555;4229.302165142717;4256.8297268109545;4261.74429534229;4704.317873908264;4771.904561908743;4871.707697538159;4955.40535135786;4965.47451309567;1243.4466662335356;1246.5823948977195;1250.8242252282826;1264.1846009323936;1265.1397050006085;843.3506200225792;876.5880036383018;883.9292856571459;885.5616469847466;888.0852721696663;4315.762633055149;4321.178975994551;4325.437693099877;4326.762028088486;4334.739915605074;4911.336969509142;4920.950790492049;4955.909699866023;4965.180745177077;4971.229459433794;4273.91452170961;4290.871273861789;4301.548337424588;4301.892452688645;4318.395424640553;2471.765182307678;2598.76558634647;2628.8422694638384;2648.576227803542;2651.960220596654;4678.362573099456;4708.858734237979;4711.340412342275;4722.905541889143;4723.456802467692;4884.778805298675;4898.608111351084;4961.206207006861;4991.700497970133;5009.373828271466;4577.679562430598;4869.147899117711;4892.633052521075;4905.117078925828;4909.484504127086;5141.53726164647;5146.3309769731195;5159.355080614923;5160.09698302803;5161.277421160966;4866.007405445696;5054.140796064605;5074.314967479343;5081.212412076134;5096.719680417613;4871.415430148405;4901.656884018227;4904.166291730486;4908.190148625436;4922.169752392317;3639.5086663300117;3642.6357364263363;3650.5801832788507;3652.598214196383;3671.7796932184156;4884.877878053077;5007.84976450707;5155.871103222449;5157.587393008475;5165.354330708661;4875.7074575525585;4931.211006238985;4992.2761199626575;4997.550220480174;4999.625028122832;4970.403551573834;4985.675931064469;4991.575716064175;4998.6750861193905;5012.598992080552;4794.832180873653;4892.559669629751;4918.43438004634;4935.864751107337;4938.851834444972;5013.147764879906;5013.348264725562;5021.748912554284;5025.346704928336;5026.140328078634;4914.336564563738;4915.721912302898;4920.434150072788;4921.163402221559;4926.827561035347 07:57:39 INFO - PROCESS | 28593 | |5;yui.html;645.5319893077519;663.777634492445;678.8167194857392;694.6144889586279;708.829880828601;12222.327771972537;13139.343032848366;13205.471781128756;13209.207447553154;13211.273379964097;13225.867741322583;13396.129251598664;13398;13405.396757145927;13417.59747207583;612.424321138131;634.2832599162939;749.5727435361846;760.3461023519768;766.9348105411046;769.1539306762572;772.7179579453515;773;773.400614523743;774.0054030570718;812.6586833529902;816.2572059425923;817.3869597801648;817.8732296494053;817.9550124743137;649.8960166373357;665.930077341877;791.2601717394255;800.0679208721832;808.022293025437;603.7222877476366;604.247711599062;605.0259082876565;605.0561124645567;605.0651743056987;13992.440302387995;14009.929950350284;14027;14027.64930876726;14030.59694030599;12520.123591348609;12676.429560669792;12819.80770288437;12916.289604071771;13042.739145217138;11144.498497567629;11346.43267836613;11525.94237028818;11688.47401866918;11853.229540079954;3184.5871923133977;3186.4423725848114;3295.439775238215;3356.110630682871;4092.1815636872448;66576;67609;67990.9999999995;68079.31920680829;68327.65836170837;10058.396496210251;10093.495325233709;10151.746206344753;10184.796304073878;10287.382757034602;17892.55268618295;17958.91020544889;17976.730349044774;18048.819511804977;18243.087845607668;6488.188976377953;6513.8697226056165;6525.151730275129;6596.373344532261;6627.237867645186;3605.9278814424088;3778.8110594470168;3781.829817658212;3812.1422679897355;3813.7139714521522;2916.387558612673;3013.9547906781418;3033.9987804024618;3035.347400308944;3042.7717921156;482.48615224785493;532.7709085093447;540.1951092871593;547.3377213571623;555.7388027627009;493.72104760810026;524.318386098071;537.4437457231746;614.0850133301349;614.3119705929388;8522.616482258314;8736.160747757005;8790.25282850952;8883.156100170474;8953.373263871597;602.7378090530633;613.2702084519408;619.4053708439858;622.2129006806304;634.1502386801616;3983.701222408331;4002.939955900664;4211.768352740567;4302.634276086567;4368.453943257093;71408;71711;73582;74812.25187748052;75294;64943.67528162424;65854.67072664606;65998.34001660018;66210.99999999904;66340;56991.715041424526;59141.704291478265;59696.70151649214;60139.39860601338;60352.698236507655;7923.326517246099;8092.271695547429;8306.87539686893;8390.399840163636;8449.873251901103;38036.80981595074;38992.22015559616;39362.80318598503;40228.19543609053;40918.38622420726;47816.7609161952;48580;51385;53624;53627.92744145017;9911.801763964537;9994.650187243411;10081.243906706879;10118.241131915283;10379.273450858367;11619;11649.359285239394;11780.293182409083;11803.409829508662;12626.684332891384;10070.546825393021;12238.571649992207;12276.631701048982;12692.238465692088;12713.046521510738;11745.706357341134;12423.503059877503;12550.87449125497;12661.240325580495;12720.23339148236;11826.76346473083;12137.150399471951;12204.145709800228;12211.26732396059;12283.38583070825;9822.263330250402;9834.262430317898;10097.495125243562;10310.587576497157;10472.738181545523;9448.811023779623;10039.74900627461;10202.846957295795;10855.2401331906;10905.300536636854 07:57:39 INFO - PROCESS | 28593 | __end_tp_report 07:57:39 INFO - PROCESS | 28593 | __start_cc_report 07:57:39 INFO - PROCESS | 28593 | _x_x_mozilla_cycle_collect,1416 07:57:39 INFO - PROCESS | 28593 | __end_cc_report 07:57:39 INFO - PROCESS | 28593 | __startTimestamp1481039859717__endTimestamp 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | ------- Summary: start ------- 07:57:39 INFO - PROCESS | 28593 | Number of tests: 6 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#0] dojo.html Cycles:165 Average:4665.07 Median:4816.33 stddev:501.75 (10.4%) stddev-sans-first:476.43 07:57:39 INFO - PROCESS | 28593 | Values: 2600.5 2621.1 2646.2 2658.1 2671.0 4541.2 4591.3 4704.2 4764.9 4789.4 4639.1 4683.3 4722.5 4755.2 4818.8 4287.6 4308.5 4347.8 4379.9 4455.8 4025.1 4358.2 4386.8 4416.5 4462.6 4162.3 4202.2 4369.1 4413.3 4445.9 4241.4 4243.1 4245.9 4247.3 4250.9 4212.6 4215.0 4215.9 4227.8 4232.7 4583.8 4675.9 4687.8 4741.8 4802.4 5063.2 5079.5 5084.8 5085.1 5131.6 5100.6 5105.4 5110.0 5114.9 5116.6 4629.1 4670.0 4680.0 4688.4 4779.3 5185.6 5186.7 5224.5 5235.7 5236.9 4915.2 4964.4 4967.0 4973.4 5014.6 4941.8 5020.1 5023.1 5023.3 5064.3 4913.0 4944.7 4945.1 4949.3 5009.8 4976.3 4977.8 4984.7 4986.9 5022.7 4252.3 4255.4 4261.3 4295.7 4297.2 3669.5 3678.9 3699.4 3707.2 3720.0 4385.7 4388.5 4402.2 4436.6 4445.3 5093.5 5099.0 5099.7 5104.6 5138.7 4281.0 4327.7 4357.5 4402.7 4445.4 4540.7 4555.4 4562.1 4577.0 4632.2 4816.3 4822.0 4823.7 4828.4 4873.9 5017.4 5029.0 5057.6 5091.4 5110.7 4681.4 4725.3 4725.7 4736.1 4811.0 5023.1 5024.2 5027.7 5066.3 5074.4 5051.3 5087.8 5089.7 5093.6 5143.1 4827.3 4874.1 4874.7 4943.8 4946.1 4894.0 4941.3 4943.0 4998.4 5002.0 4884.7 4885.3 4888.9 4893.6 4907.9 4979.4 4984.4 4987.6 4990.8 5037.3 4693.0 4783.5 4788.0 4829.9 4835.0 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#1] ext.html Cycles:180 Average:44759.98 Median:19034.04 stddev:79255.65 (416.4%) stddev-sans-first:79408.50 07:57:39 INFO - PROCESS | 28593 | Values: 559.7 561.8 568.1 568.9 570.4 27693.2 37921.6 39279.4 39393.8 42604.4 39169.8 39535.0 39616.4 39678.8 39701.4 7281.3 7541.3 7662.6 7687.1 7689.8 7287.7 7534.8 7538.1 9640.0 9907.8 9847.4 9853.2 9905.9 9907.7 9920.5 9777.7 9827.6 9840.1 9841.5 9844.0 9730.8 9754.7 9766.9 9769.5 9784.8 36713.4 37025.3 37057.8 37070.6 37120.0 2928.4 3028.6 3107.7 3242.0 3538.4 27545.0 27636.6 27704.6 27711.2 28444.4 3293.0 3380.8 3395.3 3466.8 3498.2 253275.0 253859.0 254978.0 256048.0 256067.0 52796.0 53132.0 53317.2 53349.0 53377.7 56330.4 56331.7 56417.4 56464.2 56483.7 13870.7 14103.3 14129.9 14135.5 14140.7 10465.2 10511.5 10552.3 10613.1 10616.3 14897.4 15299.5 16034.4 16454.3 16655.8 6680.8 6767.5 6802.7 6967.9 7059.9 738.7 818.9 854.0 866.6 940.9 26233.7 27025.3 27282.0 27826.9 27829.0 909.2 994.8 995.9 1014.2 1018.2 13536.0 14628.9 14641.9 14752.8 14927.7 364581.0 369860.0 370333.0 370370.0 371718.0 31713.0 31853.7 31894.5 31919.5 31958.4 1058.1 1079.2 1134.6 1163.4 1188.2 25894.2 27832.9 28162.6 28441.4 28560.7 39913.4 40463.8 40530.0 40606.6 40657.2 266347.0 267561.0 268335.0 268345.0 268548.0 24003.2 24372.4 24982.8 25048.1 26690.2 39365.0 39618.6 39737.4 39828.4 40463.4 33591.5 34197.0 34377.8 34378.8 34563.7 33266.0 34107.0 34601.3 34829.8 35036.3 34306.5 34358.8 34484.5 34660.1 34762.5 28159.4 28795.7 32013.4 32409.7 32485.0 24220.0 24444.8 24594.1 24824.6 24902.5 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#2] jquery.html Cycles:180 Average:22656.97 Median:49132.75 stddev:57815.01 (117.7%) stddev-sans-first:57952.95 07:57:39 INFO - PROCESS | 28593 | Values: 354.4 371.1 377.5 378.7 399.7 12293.6 12434.9 13064.5 15534.7 16308.1 16603.5 17138.5 17200.9 17250.0 17288.9 4681.0 5141.2 5157.5 5175.9 5176.4 3693.2 3856.6 5053.3 5145.8 5146.0 3857.6 3865.3 3940.4 6018.1 6112.3 6034.8 6103.8 6105.0 6115.0 6120.5 5239.9 5304.1 5362.5 5363.7 5364.8 19635.2 19669.1 19767.2 19810.4 19867.6 1888.3 1893.9 1894.4 1936.7 1960.7 8579.8 8769.0 8923.6 9412.2 9490.3 1716.3 1724.2 1736.4 1743.7 1757.5 59218.4 60847.4 66917.3 68357.0 69900.7 9126.8 9264.6 9368.5 9839.3 9840.4 13160.5 13169.4 13180.2 13185.2 13207.1 6618.1 6777.4 6873.2 6873.9 6945.4 6133.8 6150.3 6239.8 6536.3 6886.1 3897.5 3967.7 4037.9 4039.2 4250.6 1688.2 1729.3 1803.4 1807.5 1815.4 763.6 818.5 843.6 865.7 884.2 15664.9 15927.8 16290.6 16350.5 16980.6 788.3 808.9 819.5 822.4 836.3 8848.0 8874.3 9111.7 9227.6 9606.9 343800.0 347115.0 347700.0 349764.0 351749.0 78209.6 78593.2 80678.6 81212.2 81691.2 894.5 898.9 900.8 915.7 921.6 13785.5 14479.1 14708.8 14848.3 15299.5 35566.0 35838.1 35857.8 36074.3 37260.8 47332.0 48412.0 49106.0 49159.5 51131.5 6374.2 6582.5 6691.8 7024.8 7236.6 10933.8 11557.5 11571.3 11734.8 12264.9 9727.9 9883.0 10244.8 10559.7 10595.7 9802.3 10166.6 10398.9 10483.2 10594.7 5083.9 5232.9 9787.3 10400.7 10641.9 6792.3 6829.4 6945.9 6977.8 7197.0 7313.3 9225.3 10040.6 10119.5 10235.9 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#3] mootools.html Cycles:180 Average:4746.38 Median:5020.71 stddev:2578.23 (51.4%) stddev-sans-first:2571.98 07:57:39 INFO - PROCESS | 28593 | Values: 1237.7 1313.2 1352.7 1408.6 1656.1 6170.8 6708.2 6967.9 6973.2 7158.4 6952.4 7031.9 7037.3 7038.5 7041.2 1807.7 1855.8 2046.2 2076.7 2078.6 2025.4 2081.4 2085.1 2088.2 2090.9 2044.6 2047.1 2050.3 2055.3 2055.9 2022.8 2067.0 2071.9 2072.3 2075.5 2056.2 2087.5 2087.7 2097.3 2108.6 7178.4 7296.6 7327.5 7377.9 7388.2 4344.7 4476.8 4480.1 4482.1 4482.4 2730.8 2937.7 2983.4 3011.4 3021.4 861.8 901.3 919.3 921.2 931.1 9474.9 9536.0 9537.0 9544.0 9567.3 3867.1 3958.2 4053.2 4059.6 4112.6 8251.3 8261.6 8268.2 8271.6 8298.5 4502.3 4506.6 4507.0 4507.5 4511.0 3462.8 3598.4 4101.0 4104.6 4107.3 3346.4 3428.6 3526.5 3546.5 3574.1 1147.5 1190.6 1193.9 1195.1 1195.2 793.9 797.6 842.6 854.7 856.3 4865.1 4898.6 4913.8 4959.2 5025.2 386.1 391.4 392.2 410.8 413.1 3384.8 3409.9 3465.2 3529.5 3590.3 8460.7 8675.3 8732.0 8744.6 8758.9 8698.2 8708.1 8724.2 8745.8 8758.8 6672.9 6749.0 6749.9 6826.9 6836.4 5014.4 5019.1 5022.3 5032.1 5068.6 7688.0 7878.1 7976.8 7997.2 8081.3 7980.4 8045.0 8102.9 8191.0 8200.6 5525.5 5577.5 6220.4 6350.5 6363.1 6486.2 6594.1 6616.3 6941.1 6962.8 6198.2 6312.9 6337.4 6421.6 6494.9 6103.9 6117.8 6233.4 6324.7 6332.6 5919.1 6020.5 6022.4 6031.9 6032.4 4345.2 4415.3 4430.9 4461.8 4510.9 4280.3 4289.6 4297.6 4401.8 4402.6 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#4] prototype.html Cycles:180 Average:4114.01 Median:4668.09 stddev:1187.10 (25.4%) stddev-sans-first:1155.07 07:57:39 INFO - PROCESS | 28593 | Values: 282.7 287.8 293.0 294.6 299.6 4580.2 4671.5 4748.2 4794.9 4799.9 4540.4 4612.4 4663.2 4664.7 4700.9 3525.4 3612.3 3717.0 3718.9 3728.3 3634.6 3730.7 3737.5 3737.9 3744.4 3701.2 3701.7 3703.1 3712.0 3712.2 3709.4 3717.8 3720.1 3721.9 3722.4 3127.8 3227.7 3260.7 3293.6 3294.4 4547.7 4587.2 4599.8 4605.6 4624.4 4205.7 4205.9 4208.4 4208.5 4210.7 4686.5 4915.5 4930.5 4948.6 4954.6 3582.4 3603.9 3611.6 3631.4 3631.9 5148.6 5168.3 5178.1 5219.4 5227.3 3703.4 3713.7 3721.4 3722.6 3726.8 3654.7 3715.9 3746.8 3765.8 3768.2 4215.6 4223.0 4229.3 4256.8 4261.7 4704.3 4771.9 4871.7 4955.4 4965.5 1243.4 1246.6 1250.8 1264.2 1265.1 843.4 876.6 883.9 885.6 888.1 4315.8 4321.2 4325.4 4326.8 4334.7 4911.3 4921.0 4955.9 4965.2 4971.2 4273.9 4290.9 4301.5 4301.9 4318.4 2471.8 2598.8 2628.8 2648.6 2652.0 4678.4 4708.9 4711.3 4722.9 4723.5 4884.8 4898.6 4961.2 4991.7 5009.4 4577.7 4869.1 4892.6 4905.1 4909.5 5141.5 5146.3 5159.4 5160.1 5161.3 4866.0 5054.1 5074.3 5081.2 5096.7 4871.4 4901.7 4904.2 4908.2 4922.2 3639.5 3642.6 3650.6 3652.6 3671.8 4884.9 5007.8 5155.9 5157.6 5165.4 4875.7 4931.2 4992.3 4997.6 4999.6 4970.4 4985.7 4991.6 4998.7 5012.6 4794.8 4892.6 4918.4 4935.9 4938.9 5013.1 5013.3 5021.7 5025.3 5026.1 4914.3 4915.7 4920.4 4921.2 4926.8 07:57:39 INFO - PROCESS | 28593 | 07:57:39 INFO - PROCESS | 28593 | [#5] yui.html Cycles:180 Average:15902.44 Median:24149.62 stddev:20673.19 (85.6%) stddev-sans-first:20699.44 07:57:39 INFO - PROCESS | 28593 | Values: 645.5 663.8 678.8 694.6 708.8 12222.3 13139.3 13205.5 13209.2 13211.3 13225.9 13396.1 13398.0 13405.4 13417.6 612.4 634.3 749.6 760.3 766.9 769.2 772.7 773.0 773.4 774.0 812.7 816.3 817.4 817.9 818.0 649.9 665.9 791.3 800.1 808.0 603.7 604.2 605.0 605.1 605.1 13992.4 14009.9 14027.0 14027.6 14030.6 12520.1 12676.4 12819.8 12916.3 13042.7 11144.5 11346.4 11525.9 11688.5 11853.2 3184.6 3186.4 3295.4 3356.1 4092.2 66576.0 67609.0 67991.0 68079.3 68327.7 10058.4 10093.5 10151.7 10184.8 10287.4 17892.6 17958.9 17976.7 18048.8 18243.1 6488.2 6513.9 6525.2 6596.4 6627.2 3605.9 3778.8 3781.8 3812.1 3813.7 2916.4 3014.0 3034.0 3035.3 3042.8 482.5 532.8 540.2 547.3 555.7 493.7 524.3 537.4 614.1 614.3 8522.6 8736.2 8790.3 8883.2 8953.4 602.7 613.3 619.4 622.2 634.2 3983.7 4002.9 4211.8 4302.6 4368.5 71408.0 71711.0 73582.0 74812.3 75294.0 64943.7 65854.7 65998.3 66211.0 66340.0 56991.7 59141.7 59696.7 60139.4 60352.7 7923.3 8092.3 8306.9 8390.4 8449.9 38036.8 38992.2 39362.8 40228.2 40918.4 47816.8 48580.0 51385.0 53624.0 53627.9 9911.8 9994.7 10081.2 10118.2 10379.3 11619.0 11649.4 11780.3 11803.4 12626.7 10070.5 12238.6 12276.6 12692.2 12713.0 11745.7 12423.5 12550.9 12661.2 12720.2 11826.8 12137.2 12204.1 12211.3 12283.4 9822.3 9834.3 10097.5 10310.6 10472.7 9448.8 10039.7 10202.8 10855.2 10905.3 07:57:39 INFO - PROCESS | 28593 | -------- Summary: end -------- 07:57:39 INFO - PROCESS | 28593 | 07:57:40 INFO - TEST-INFO | 28593: exit 0 07:57:40 INFO - TEST-OK | dromaeo_css | took 1123630ms 07:57:40 INFO - TEST-START | kraken 07:57:40 INFO - operating with platform_type : linux_ 07:57:40 INFO - Initialising browser for kraken test... 07:57:40 INFO - TEST-INFO | started process 28898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2y6yGq/profile http://localhost:34775/getInfo.html) 07:57:44 INFO - PROCESS | 28898 | __metrics Screen width/height:1600/1200 07:57:44 INFO - PROCESS | 28898 | colorDepth:24 07:57:44 INFO - PROCESS | 28898 | Browser inner width/height: 1024/697 07:57:44 INFO - PROCESS | 28898 | __metrics 07:57:45 INFO - PROCESS | 28898 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:45 INFO - PROCESS | 28898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:46 INFO - TEST-INFO | 28898: exit 0 07:57:46 INFO - Browser initialized. 07:57:46 INFO - Running cycle 1/1 for kraken test... 07:57:46 INFO - TEST-INFO | started process 28978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2y6yGq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:59 INFO - PROCESS | 28978 | RSS: Main: 174141440 07:57:59 INFO - PROCESS | 28978 | 07:58:01 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34775/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:02 INFO - PROCESS | 28978 | RSS: Main: 235843584 07:58:02 INFO - PROCESS | 28978 | 07:58:05 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34775/tests/kraken/driver.html?testName=audio-dft) 07:58:06 INFO - PROCESS | 28978 | RSS: Main: 218673152 07:58:06 INFO - PROCESS | 28978 | 07:58:09 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34775/tests/kraken/driver.html?testName=audio-fft) 07:58:10 INFO - PROCESS | 28978 | RSS: Main: 300187648 07:58:10 INFO - PROCESS | 28978 | 07:58:12 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34775/tests/kraken/driver.html?testName=audio-oscillator) 07:58:12 INFO - PROCESS | 28978 | RSS: Main: 210862080 07:58:12 INFO - PROCESS | 28978 | 07:58:15 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:15 INFO - PROCESS | 28978 | RSS: Main: 214552576 07:58:15 INFO - PROCESS | 28978 | 07:58:18 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34775/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:19 INFO - PROCESS | 28978 | RSS: Main: 254562304 07:58:19 INFO - PROCESS | 28978 | 07:58:22 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34775/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:23 INFO - PROCESS | 28978 | RSS: Main: 248520704 07:58:23 INFO - PROCESS | 28978 | 07:58:26 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34775/tests/kraken/driver.html?testName=json-parse-financial) 07:58:27 INFO - PROCESS | 28978 | RSS: Main: 250130432 07:58:27 INFO - PROCESS | 28978 | 07:58:28 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:29 INFO - PROCESS | 28978 | RSS: Main: 213680128 07:58:29 INFO - PROCESS | 28978 | 07:58:31 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:31 INFO - PROCESS | 28978 | RSS: Main: 221106176 07:58:31 INFO - PROCESS | 28978 | 07:58:34 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:34 INFO - PROCESS | 28978 | RSS: Main: 229228544 07:58:34 INFO - PROCESS | 28978 | 07:58:37 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:38 INFO - PROCESS | 28978 | RSS: Main: 237752320 07:58:38 INFO - PROCESS | 28978 | 07:58:41 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:42 INFO - PROCESS | 28978 | RSS: Main: 234471424 07:58:42 INFO - PROCESS | 28978 | 07:58:43 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:34775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34775/tests/kraken/driver.html?testName=ai-astar) 07:58:44 INFO - PROCESS | 28978 | RSS: Main: 286081024 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | __start_tp_report 07:58:44 INFO - PROCESS | 28978 | _x_x_mozilla_page_load 07:58:44 INFO - PROCESS | 28978 | _x_x_mozilla_page_load_details 07:58:44 INFO - PROCESS | 28978 | |i|pagename|runs| 07:58:44 INFO - PROCESS | 28978 | |0;ai-astar;112;114;115;115;114;114;116;115;113;115 07:58:44 INFO - PROCESS | 28978 | |1;audio-beat-detection;155;130;136;166;133;132;128;129;149;134 07:58:44 INFO - PROCESS | 28978 | |2;audio-dft;161;161;163;164;162;162;162;164;165;162 07:58:44 INFO - PROCESS | 28978 | |3;audio-fft;76;78;79;123;77;77;76;76;91;77 07:58:44 INFO - PROCESS | 28978 | |4;audio-oscillator;83;82;117;83;83;83;98;82;83;105 07:58:44 INFO - PROCESS | 28978 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 07:58:44 INFO - PROCESS | 28978 | |6;imaging-darkroom;147;147;147;147;147;146;146;147;147;146 07:58:44 INFO - PROCESS | 28978 | |7;imaging-desaturate;96;96;96;95;96;95;95;96;95;96 07:58:44 INFO - PROCESS | 28978 | |8;json-parse-financial;64;69;64;63;64;65;66;65;69;64 07:58:44 INFO - PROCESS | 28978 | |9;json-stringify-tinderbox;65;66;65;65;65;66;66;66;66;66 07:58:44 INFO - PROCESS | 28978 | |10;stanford-crypto-aes;84;91;88;93;88;85;83;86;84;84 07:58:44 INFO - PROCESS | 28978 | |11;stanford-crypto-ccm;148;143;143;141;146;139;151;139;183;145 07:58:44 INFO - PROCESS | 28978 | |12;stanford-crypto-pbkdf2;179;178;180;183;178;181;179;184;178;181 07:58:44 INFO - PROCESS | 28978 | |13;stanford-crypto-sha256-iterative;71;70;71;70;72;71;71;70;69;70 07:58:44 INFO - PROCESS | 28978 | __end_tp_report 07:58:44 INFO - PROCESS | 28978 | __start_cc_report 07:58:44 INFO - PROCESS | 28978 | _x_x_mozilla_cycle_collect,1989 07:58:44 INFO - PROCESS | 28978 | __end_cc_report 07:58:44 INFO - PROCESS | 28978 | __startTimestamp1481039924092__endTimestamp 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | ------- Summary: start ------- 07:58:44 INFO - PROCESS | 28978 | Number of tests: 14 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:0.88 07:58:44 INFO - PROCESS | 28978 | Values: 112.0 114.0 115.0 115.0 114.0 114.0 116.0 115.0 113.0 115.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.00 stddev:12.93 (9.6%) stddev-sans-first:12.39 07:58:44 INFO - PROCESS | 28978 | Values: 155.0 130.0 136.0 166.0 133.0 132.0 128.0 129.0 149.0 134.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 07:58:44 INFO - PROCESS | 28978 | Values: 161.0 161.0 163.0 164.0 162.0 162.0 162.0 164.0 165.0 162.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#3] audio-fft Cycles:10 Average:83.00 Median:77.00 stddev:14.76 (19.2%) stddev-sans-first:15.43 07:58:44 INFO - PROCESS | 28978 | Values: 76.0 78.0 79.0 123.0 77.0 77.0 76.0 76.0 91.0 77.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.00 stddev:12.43 (15.0%) stddev-sans-first:12.93 07:58:44 INFO - PROCESS | 28978 | Values: 83.0 82.0 117.0 83.0 83.0 83.0 98.0 82.0 83.0 105.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:58:44 INFO - PROCESS | 28978 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:58:44 INFO - PROCESS | 28978 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:58:44 INFO - PROCESS | 28978 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.19 07:58:44 INFO - PROCESS | 28978 | Values: 64.0 69.0 64.0 63.0 64.0 65.0 66.0 65.0 69.0 64.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:58:44 INFO - PROCESS | 28978 | Values: 65.0 66.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:3.34 (3.8%) stddev-sans-first:3.41 07:58:44 INFO - PROCESS | 28978 | Values: 84.0 91.0 88.0 93.0 88.0 85.0 83.0 86.0 84.0 84.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:145.50 stddev:12.94 (8.9%) stddev-sans-first:13.73 07:58:44 INFO - PROCESS | 28978 | Values: 148.0 143.0 143.0 141.0 146.0 139.0 151.0 139.0 183.0 145.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:180.50 stddev:2.13 (1.2%) stddev-sans-first:2.22 07:58:44 INFO - PROCESS | 28978 | Values: 179.0 178.0 180.0 183.0 178.0 181.0 179.0 184.0 178.0 181.0 07:58:44 INFO - PROCESS | 28978 | 07:58:44 INFO - PROCESS | 28978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 07:58:44 INFO - PROCESS | 28978 | Values: 71.0 70.0 71.0 70.0 72.0 71.0 71.0 70.0 69.0 70.0 07:58:44 INFO - PROCESS | 28978 | -------- Summary: end -------- 07:58:44 INFO - PROCESS | 28978 | 07:58:45 INFO - TEST-INFO | 28978: exit 0 07:58:45 INFO - TEST-OK | kraken | took 64965ms 07:58:45 INFO - SUITE-END | took 1188s 07:58:45 INFO - Completed test suite (00:19:48) 07:58:45 INFO - javascript benchmark 07:58:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.4669042846217, 2621.0826210826203, 2646.232592548162, 2658.0696756135353, 2671.038426166581, 4541.1598854212, 4591.311303304497, 4704.249402107973, 4764.928526072112, 4789.401324834395, 4639.141758774621, 4683.32091846682, 4722.480527142012, 4755.2153894607345, 4818.759062046901, 4287.635550978171, 4308.526062133163, 4347.826086956518, 4379.912401751963, 4455.8217671293105, 4025.087329310891, 4358.215521206182, 4386.824527018915, 4416.470023597173, 4462.598366147046, 4162.313218319004, 4202.180574787918, 4369.060651959812, 4413.293872980308, 4445.933311000337, 4241.448611680493, 4243.087736136715, 4245.936310955338, 4247.299195632717, 4250.851220207278, 4212.641925436342, 4215.0, 4215.873523794291, 4227.767472788995, 4232.703710740249, 4583.793729282191, 4675.859724208245, 4687.789049492781, 4741.8103275868925, 4802.447718512381, 5063.240513922941, 5079.517445842639, 5084.77118529667, 5085.059264036166, 5131.563817075553, 5100.617453690951, 5105.412877519096, 5110.0, 5114.923276150861, 5116.616253780981, 4629.143608432417, 4669.972606026737, 4679.953200467951, 4688.413948256468, 4779.3070004849105, 5185.637005409585, 5186.662866913639, 5224.50367215114, 5235.685858848481, 5236.92144617831, 4915.188993816052, 4964.35463389757, 4967.006598680278, 4973.378327709036, 5014.648974571818, 4941.827036053721, 5020.1214787412055, 5023.14606516893, 5023.271625614266, 5064.34163558735, 4912.968276661941, 4944.728039957837, 4945.060438516671, 4949.331840201598, 5009.824656137018, 4976.253561965734, 4977.8257760978195, 4984.7258400788305, 4986.925196122061, 5022.673526220784, 4252.29837076885, 4255.446791917093, 4261.2542805009, 4295.72077814941, 4297.247981603269, 3669.5046168766876, 3678.8712395066045, 3699.389600715852, 3707.2400157967554, 3720.032791474236, 4385.736855788663, 4388.451443569554, 4402.16358891816, 4436.5785250401805, 4445.288753799441, 5093.465186155475, 5099.0, 5099.745012749348, 5104.566111880532, 5138.691678499302, 4280.978595107004, 4327.65378769704, 4357.520672725997, 4402.735835849795, 4445.422095127613, 4540.659450541222, 4555.362249285103, 4562.133194693064, 4576.954230457719, 4632.166210082218, 4816.325714399917, 4821.95178048215, 4823.710577365369, 4828.396450443694, 4873.926891096708, 5017.448080711192, 5028.974855125847, 5057.6459647824295, 5091.363579552556, 5110.693358398508, 4681.391419115629, 4725.314829349793, 4725.716457012591, 4736.123817093849, 4811.037792441596, 5023.120953833138, 5024.171011783015, 5027.69833809958, 5066.290719299227, 5074.416442109205, 5051.318072060371, 5087.821926232564, 5089.720065396439, 5093.617978651542, 5143.099957507496, 4827.300041494034, 4874.147024270809, 4874.683145595525, 4943.826966056171, 4946.08497427977, 4894.045661096195, 4941.308216849572, 4943.0361079590575, 4998.425181104074, 5001.974990125026, 4884.682495637772, 4885.267209918541, 4888.902221955612, 4893.551311555345, 4907.9263811043575, 4979.352684151182, 4984.42679091909, 4987.576056035133, 4990.8253211137435, 5037.294778730908, 4692.9530704692515, 4783.4738178801, 4788.0, 4829.927551086666, 4835.0], "value": 4632.51492671376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6977632078678, 561.8258339914629, 568.0513542384218, 568.8691600931788, 570.3982298674898, 27693.169204923834, 37921.620783792154, 39279.410808837856, 39393.8030309848, 42604.36093458601, 39169.804150979275, 39535.0, 39616.405753913714, 39678.801605992005, 39701.40447893277, 7281.271872812729, 7541.321281084687, 7662.616869156548, 7687.077550693896, 7689.807754806118, 7287.708491660327, 7534.8116297092465, 7538.095428548582, 9640.0, 9907.752306192331, 9847.359921605108, 9853.211743060538, 9905.851412228822, 9907.702768916908, 9920.45437500937, 9777.657781977632, 9827.557759900787, 9840.06519380665, 9841.45871977041, 9844.0, 9730.805383892282, 9754.707358779247, 9766.853497197548, 9769.51152442375, 9784.755381115458, 36713.449298260544, 37025.25949481022, 37057.81471092627, 37070.62929370699, 37120.0, 2928.3996780659913, 3028.5911401960893, 3107.6892310768967, 3241.983790081058, 3538.3630946429635, 27545.0, 27636.58545121825, 27704.584431233547, 27711.168664940084, 28444.431111377657, 3292.96707032929, 3380.7633465657414, 3395.3209358128224, 3466.7746596471147, 3498.1604414940484, 253275.0, 253859.0, 254978.0, 256048.0, 256067.0, 52796.0, 53132.0, 53317.200241996405, 53349.0, 53377.72645239994, 56330.43669563334, 56331.71834140885, 56417.43582564204, 56464.22429308427, 56483.71758141183, 13870.722585548434, 14103.294835258195, 14129.85870141306, 14135.505257315945, 14140.717185656229, 10465.215108866865, 10511.474426278655, 10552.314099583657, 10613.09788667972, 10616.309939853885, 14897.404103835725, 15299.46451874179, 16034.358625654842, 16454.259558319904, 16655.750163747554, 6680.766173183915, 6767.52627316093, 6802.659867006729, 6967.93032069683, 7059.870420732658, 738.6712912753773, 818.9186100247947, 853.9914600854037, 866.5883705239961, 940.9059094090536, 26233.737662623513, 27025.324366890985, 27282.0, 27826.86086569554, 27829.0, 909.1681111782777, 994.8308787506141, 995.8904520502739, 1014.1734486393566, 1018.2007124407453, 13536.0, 14628.853711462749, 14641.853581464049, 14752.778708319383, 14927.701445971019, 364581.0, 369860.0, 370333.0, 370370.0, 371718.0, 31713.04860854178, 31853.681463185072, 31894.521582176287, 31919.52120718191, 31958.36083278368, 1058.0636137018794, 1079.2121751121724, 1134.6142311614092, 1163.3717792392013, 1188.197966372695, 25894.151643318844, 27832.86083569569, 28162.577561337006, 28441.43117137687, 28560.714392856637, 39913.40129897996, 40463.797681011405, 40530.0, 40606.59393406028, 40657.18685626212, 266347.0, 267561.0, 268335.0, 268345.0, 268548.0, 24003.159889404487, 24372.390690232885, 24982.75017249877, 25048.123315683864, 26690.19929402121, 39365.0, 39618.60381396149, 39737.40393894036, 39828.39004067034, 40463.393049104874, 33591.49612755762, 34197.0, 34377.82811086029, 34378.82810586031, 34563.654363456044, 33266.0, 34107.0, 34601.307973840885, 34829.825850870584, 35036.299274014884, 34306.48540271948, 34358.82820585981, 34484.48273275853, 34660.133496662784, 34762.478562822085, 28159.43681126325, 28795.712042879302, 32013.359732804747, 32409.67590324161, 32485.02544923656, 24220.0, 24444.755552444247, 24594.139205127736, 24824.627630585917, 24902.501949960537], "value": 17161.59169189677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.36922278344554, 371.11859334081555, 377.48473333899227, 378.7462400191871, 399.670272025579, 12293.569725059624, 12434.937825310872, 13064.542741004067, 15534.68930621387, 16308.103054332007, 16603.50189494314, 17138.485845424628, 17200.913995430037, 17250.0, 17288.91355543224, 4680.976595117028, 5141.203113517392, 5157.5358217760395, 5175.948240517603, 5176.404713457944, 3693.150575367654, 3856.5564960029533, 5053.292539044537, 5145.819896303611, 5146.0222557714105, 3857.614238576134, 3865.323568375537, 3940.389239667856, 6018.097285407181, 6112.266528016622, 6034.818955431344, 6103.816885493442, 6104.962156433373, 6115.021596544531, 6120.479759220471, 5239.947600524022, 5304.071787437183, 5362.51737343641, 5363.678179309254, 5364.8122315718765, 19635.214591416327, 19669.11488982999, 19767.209311627517, 19810.40568782939, 19867.602647947104, 1888.2730148892638, 1893.8863668179954, 1894.393793985925, 1936.7094935759749, 1960.725498430221, 8579.828403431959, 8769.0, 8923.643054277822, 9412.199963003153, 9490.28822838283, 1716.347787840625, 1724.1982478147722, 1736.4443378119006, 1743.7384392341123, 1757.4639734880857, 59218.40781592215, 60847.39152608462, 66917.29323308247, 68357.0, 69900.65049674718, 9126.817463650823, 9264.629414823332, 9368.531573421302, 9839.311248212556, 9840.3603765755, 13160.473581056842, 13169.407376668072, 13180.209187448592, 13185.208887466782, 13207.141535800141, 6618.106555615027, 6777.423918966844, 6873.20958089816, 6873.931260687429, 6945.40964018054, 6133.785317513865, 6150.292716337589, 6239.78160764371, 6536.3136870627895, 6886.070380498569, 3897.4543563901075, 3967.6874683102387, 4037.9394309085387, 4039.1517781265675, 4250.574942505787, 1688.223417228089, 1729.3169198166904, 1803.4319189455541, 1807.4939017074978, 1815.3827698582545, 763.5723994563062, 818.5497976113234, 843.5992903370973, 865.6710450028949, 884.1821315283337, 15664.921675391777, 15927.840721592636, 16290.592735181715, 16350.509484715478, 16980.575485612713, 788.2669117720575, 808.8584497712877, 819.4632515702106, 822.407866336249, 836.2975100915261, 8848.0, 8874.334424918157, 9111.681091161778, 9227.630894764134, 9606.903930960601, 343800.0, 347115.0, 347700.0, 349764.0, 351749.0, 78209.60895195602, 78593.21406785859, 80678.59660701659, 81212.18787812165, 81691.18308816955, 894.49461054504, 898.9146031127033, 900.8018235988203, 915.7115508614766, 921.6313474610209, 13785.51750688721, 14479.131252124906, 14708.779368309699, 14848.257587120384, 15299.46451874179, 35566.0, 35838.10404739902, 35857.82071089628, 36074.27851443009, 37260.81369593135, 47332.0, 48412.0, 49106.0, 49159.50840491549, 51131.488685114164, 6374.235091789015, 6582.506312026521, 6691.825156823954, 7024.754133605504, 7236.565806051653, 10933.781324373309, 11557.47991340375, 11571.305721656727, 11734.765304694029, 12264.877351226374, 9727.854082188915, 9883.0, 10244.846327304947, 10559.736006599896, 10595.735106622087, 9802.313838031268, 10166.627505286691, 10398.896011040095, 10483.21375896826, 10594.735131621772, 5083.898322033465, 5232.947670523246, 9787.265955053257, 10400.687979360631, 10641.882602326645, 6792.320767923168, 6829.385355318045, 6945.895811562932, 6977.825554361181, 7196.9640151801, 7313.305236002571, 9225.261979041794, 10040.64857729976, 10119.544620491948, 10235.897641023494], "value": 7818.748037798949, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.6782036670463, 1313.1595778701633, 1352.6753579141005, 1408.5703860322596, 1656.1305314709784, 6170.784022559212, 6708.228553716324, 6967.895481567781, 6973.198082220546, 7158.427325813936, 6952.409045231148, 7031.8945215821805, 7037.331453511908, 7038.507304488688, 7041.225465198824, 1807.6565452564037, 1855.8422534084618, 2046.232662751472, 2076.688496725488, 2078.5738923520717, 2025.4025062606565, 2081.4172031831113, 2085.092984551725, 2088.1751708075303, 2090.8745475271458, 2044.6421876171685, 2047.119738512439, 2050.28240115959, 2055.321743824534, 2055.856090073695, 2022.7774944756138, 2067.0491573876034, 2071.906764195607, 2072.336852207294, 2075.5122546201783, 2056.1775289884017, 2087.5198704298095, 2087.65553683642, 2097.3078883968255, 2108.5993661204475, 7178.353948144692, 7296.562206267641, 7327.450441216877, 7377.926220737778, 7388.150362708304, 4344.717593356421, 4476.753778542179, 4480.081583275453, 4482.125985432842, 4482.394876691637, 2730.781537476997, 2937.7209165129493, 2983.4331477019296, 3011.382666553351, 3021.365513242222, 861.7974775927652, 901.2969883490888, 919.3013309884469, 921.230772305126, 931.1237855720728, 9474.905250947471, 9536.046395360478, 9536.952315238448, 9544.0, 9567.282453815991, 3867.1105645701646, 3958.1687845552183, 4053.2096241232675, 4059.6143366380147, 4112.609302116294, 8251.33989280856, 8261.586920654063, 8268.214519620748, 8271.627776750061, 8298.460600060977, 4502.279635258343, 4506.639468842484, 4506.954930450719, 4507.459104907432, 4510.977445112753, 3462.774919630216, 3598.4062629666337, 4100.958990410118, 4104.56902025289, 4107.260693075275, 3346.397648423307, 3428.6228514863346, 3526.4785678240182, 3546.4680297954997, 3574.0528759878653, 1147.5352482244705, 1190.6428071578491, 1193.8507686539183, 1195.1454709882476, 1195.1813008089487, 793.9007624046994, 797.5972134072256, 842.6039761312173, 854.6880388658095, 856.3063918226256, 4865.099956508057, 4898.608111351084, 4913.828016019422, 4959.181735013754, 5025.246213068069, 386.1042381674544, 391.35231192376665, 392.22926948546245, 410.8007616306089, 413.12623800661385, 3384.8476818543227, 3409.8636054558037, 3465.1856813648774, 3529.5411596492804, 3590.2998915211283, 8460.746177614681, 8675.349348798865, 8731.956340218385, 8744.606492707844, 8758.91241087581, 8698.173673501007, 8708.08565100668, 8724.214820666171, 8745.825083498294, 8758.781030474289, 6672.899906501407, 6749.0, 6749.932500675029, 6826.8634627308165, 6836.418904393083, 5014.42334131565, 5019.071471777733, 5022.347094877642, 5032.0690672225755, 5068.619853510928, 7687.962125113038, 7878.054633444023, 7976.760697179094, 7997.160298168608, 8081.313088387553, 7980.441369104107, 8045.0, 8102.878456823035, 8191.017077950684, 8200.58997050157, 5525.502704756591, 5577.498025177591, 6220.440160385587, 6350.523710721622, 6363.077353783768, 6486.2216534016225, 6594.142761440982, 6616.305287944889, 6941.062956500808, 6962.756303529352, 6198.2252218472695, 6312.873742525216, 6337.429631333202, 6421.5504914657395, 6494.935050649433, 6103.938960610337, 6117.785877494266, 6233.438990490878, 6324.683765811783, 6332.588381755171, 5919.141724450017, 6020.458158765732, 6022.427869352405, 6031.909521357271, 6032.3967603239325, 4345.174416860787, 4415.27148020573, 4430.889227769331, 4461.821527139008, 4510.909781804411, 4280.293751530962, 4289.6139347458875, 4297.613214810682, 4401.7799110043725, 4402.581754733295], "value": 3810.5538572326086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7073978432323, 287.78991336324486, 292.9663088744795, 294.5508100147276, 299.6075141564549, 4580.221362368397, 4671.532846715327, 4748.240281554952, 4794.904101917964, 4799.856004319871, 4540.3870477485525, 4612.377329060576, 4663.207254766689, 4664.650151238662, 4700.882477938053, 3525.4006818840858, 3612.277544491099, 3717.0, 3718.9070273243115, 3728.310262601414, 3634.582512820002, 3730.7388482806214, 3737.4954381158605, 3737.8878633641034, 3744.3634582121103, 3701.1857391373856, 3701.68535674468, 3703.1112532992156, 3712.0, 3712.164762928333, 3709.350863598859, 3717.75834570752, 3720.144366795625, 3721.9441708374397, 3722.4416337549314, 3127.781055326128, 3227.677232276777, 3260.6576309487637, 3293.6047674279002, 3294.357600267949, 4547.658925580595, 4587.188060715998, 4599.83900563482, 4605.631549476034, 4624.427694583824, 4205.663546916239, 4205.864416607529, 4208.389783481378, 4208.516974984774, 4210.726302790309, 4686.461056978423, 4915.483874193194, 4930.531599498042, 4948.57937075349, 4954.578860796837, 3582.39099353108, 3603.94594081089, 3611.638836116367, 3631.400818864884, 3631.891043268706, 5148.639595228336, 5168.302279192299, 5178.14560597501, 5219.399769026611, 5227.320448341729, 3703.425968974759, 3713.721470889694, 3721.404575267944, 3722.6091260417807, 3726.8136593170234, 3654.7025805838543, 3715.888523344304, 3746.775193488345, 3765.755225910307, 3768.1898391845884, 4215.557366476537, 4222.978885105555, 4229.302165142717, 4256.8297268109545, 4261.74429534229, 4704.317873908264, 4771.904561908743, 4871.707697538159, 4955.40535135786, 4965.47451309567, 1243.4466662335356, 1246.5823948977195, 1250.8242252282826, 1264.1846009323936, 1265.1397050006085, 843.3506200225792, 876.5880036383018, 883.9292856571459, 885.5616469847466, 888.0852721696663, 4315.762633055149, 4321.178975994551, 4325.437693099877, 4326.762028088486, 4334.739915605074, 4911.336969509142, 4920.950790492049, 4955.909699866023, 4965.180745177077, 4971.229459433794, 4273.91452170961, 4290.871273861789, 4301.548337424588, 4301.892452688645, 4318.395424640553, 2471.765182307678, 2598.76558634647, 2628.8422694638384, 2648.576227803542, 2651.960220596654, 4678.362573099456, 4708.858734237979, 4711.340412342275, 4722.905541889143, 4723.456802467692, 4884.778805298675, 4898.608111351084, 4961.206207006861, 4991.700497970133, 5009.373828271466, 4577.679562430598, 4869.147899117711, 4892.633052521075, 4905.117078925828, 4909.484504127086, 5141.53726164647, 5146.3309769731195, 5159.355080614923, 5160.09698302803, 5161.277421160966, 4866.007405445696, 5054.140796064605, 5074.314967479343, 5081.212412076134, 5096.719680417613, 4871.415430148405, 4901.656884018227, 4904.166291730486, 4908.190148625436, 4922.169752392317, 3639.5086663300117, 3642.6357364263363, 3650.5801832788507, 3652.598214196383, 3671.7796932184156, 4884.877878053077, 5007.84976450707, 5155.871103222449, 5157.587393008475, 5165.354330708661, 4875.7074575525585, 4931.211006238985, 4992.2761199626575, 4997.550220480174, 4999.625028122832, 4970.403551573834, 4985.675931064469, 4991.575716064175, 4998.6750861193905, 5012.598992080552, 4794.832180873653, 4892.559669629751, 4918.43438004634, 4935.864751107337, 4938.851834444972, 5013.147764879906, 5013.348264725562, 5021.748912554284, 5025.346704928336, 5026.140328078634, 4914.336564563738, 4915.721912302898, 4920.434150072788, 4921.163402221559, 4926.827561035347], "value": 3737.2133467337467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.5319893077519, 663.777634492445, 678.8167194857392, 694.6144889586279, 708.829880828601, 12222.327771972537, 13139.343032848366, 13205.471781128756, 13209.207447553154, 13211.273379964097, 13225.867741322583, 13396.129251598664, 13398.0, 13405.396757145927, 13417.59747207583, 612.424321138131, 634.2832599162939, 749.5727435361846, 760.3461023519768, 766.9348105411046, 769.1539306762572, 772.7179579453515, 773.0, 773.400614523743, 774.0054030570718, 812.6586833529902, 816.2572059425923, 817.3869597801648, 817.8732296494053, 817.9550124743137, 649.8960166373357, 665.930077341877, 791.2601717394255, 800.0679208721832, 808.022293025437, 603.7222877476366, 604.247711599062, 605.0259082876565, 605.0561124645567, 605.0651743056987, 13992.440302387995, 14009.929950350284, 14027.0, 14027.64930876726, 14030.59694030599, 12520.123591348609, 12676.429560669792, 12819.80770288437, 12916.289604071771, 13042.739145217138, 11144.498497567629, 11346.43267836613, 11525.94237028818, 11688.47401866918, 11853.229540079954, 3184.5871923133977, 3186.4423725848114, 3295.439775238215, 3356.110630682871, 4092.1815636872448, 66576.0, 67609.0, 67990.9999999995, 68079.31920680829, 68327.65836170837, 10058.396496210251, 10093.495325233709, 10151.746206344753, 10184.796304073878, 10287.382757034602, 17892.55268618295, 17958.91020544889, 17976.730349044774, 18048.819511804977, 18243.087845607668, 6488.188976377953, 6513.8697226056165, 6525.151730275129, 6596.373344532261, 6627.237867645186, 3605.9278814424088, 3778.8110594470168, 3781.829817658212, 3812.1422679897355, 3813.7139714521522, 2916.387558612673, 3013.9547906781418, 3033.9987804024618, 3035.347400308944, 3042.7717921156, 482.48615224785493, 532.7709085093447, 540.1951092871593, 547.3377213571623, 555.7388027627009, 493.72104760810026, 524.318386098071, 537.4437457231746, 614.0850133301349, 614.3119705929388, 8522.616482258314, 8736.160747757005, 8790.25282850952, 8883.156100170474, 8953.373263871597, 602.7378090530633, 613.2702084519408, 619.4053708439858, 622.2129006806304, 634.1502386801616, 3983.701222408331, 4002.939955900664, 4211.768352740567, 4302.634276086567, 4368.453943257093, 71408.0, 71711.0, 73582.0, 74812.25187748052, 75294.0, 64943.67528162424, 65854.67072664606, 65998.34001660018, 66210.99999999904, 66340.0, 56991.715041424526, 59141.704291478265, 59696.70151649214, 60139.39860601338, 60352.698236507655, 7923.326517246099, 8092.271695547429, 8306.87539686893, 8390.399840163636, 8449.873251901103, 38036.80981595074, 38992.22015559616, 39362.80318598503, 40228.19543609053, 40918.38622420726, 47816.7609161952, 48580.0, 51385.0, 53624.0, 53627.92744145017, 9911.801763964537, 9994.650187243411, 10081.243906706879, 10118.241131915283, 10379.273450858367, 11619.0, 11649.359285239394, 11780.293182409083, 11803.409829508662, 12626.684332891384, 10070.546825393021, 12238.571649992207, 12276.631701048982, 12692.238465692088, 12713.046521510738, 11745.706357341134, 12423.503059877503, 12550.87449125497, 12661.240325580495, 12720.23339148236, 11826.76346473083, 12137.150399471951, 12204.145709800228, 12211.26732396059, 12283.38583070825, 9822.263330250402, 9834.262430317898, 10097.495125243562, 10310.587576497157, 10472.738181545523, 9448.811023779623, 10039.74900627461, 10202.846957295795, 10855.2401331906, 10905.300536636854], "value": 6409.484825404741, "unit": "score"}], "name": "dromaeo_css", "value": 6198.983536519327, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 115.0, 114.0, 114.0, 116.0, 115.0, 113.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 136.0, 166.0, 133.0, 132.0, 128.0, 129.0, 149.0, 134.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 164.0, 162.0, 162.0, 162.0, 164.0, 165.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 79.0, 123.0, 77.0, 77.0, 76.0, 76.0, 91.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 117.0, 83.0, 83.0, 83.0, 98.0, 82.0, 83.0, 105.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 64.0, 63.0, 64.0, 65.0, 66.0, 65.0, 69.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 88.0, 93.0, 88.0, 85.0, 83.0, 86.0, 84.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 143.0, 141.0, 146.0, 139.0, 151.0, 139.0, 183.0, 145.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 180.0, 183.0, 178.0, 181.0, 179.0, 184.0, 178.0, 181.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 70.0, 72.0, 71.0, 71.0, 70.0, 69.0, 70.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1563.9999999999998, "alertThreshold": 2.0}]} 07:58:45 INFO - Return code: 0 07:58:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:45 INFO - # TBPL SUCCESS # 07:58:45 INFO - Running post-action listener: _resource_record_post_action 07:58:45 INFO - [mozharness: 2016-12-06 15:58:45.899286Z] Finished run-tests step (success) 07:58:45 INFO - Running post-run listener: _resource_record_post_run 07:58:45 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402210816; Read time: 12; Write time: 298896 07:58:45 INFO - TinderboxPrint: CPU usage
13.1% 07:58:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:58:45 INFO - TinderboxPrint: I/O write bytes / time
402,210,816 / 298,896 07:58:45 INFO - TinderboxPrint: CPU idle
8,356.2 (86.9%) 07:58:45 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 07:58:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110362624; Read time: 0; Write time: 73552 07:58:45 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291848192; Read time: 0; Write time: 225344 07:58:46 INFO - Running post-run listener: _upload_blobber_files 07:58:46 INFO - Blob upload gear active. 07:58:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:58:46 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:46 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:47 INFO - (blobuploader) - INFO - Done attempting. 07:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:50 INFO - (blobuploader) - INFO - Done attempting. 07:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:51 INFO - (blobuploader) - INFO - Done attempting. 07:58:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:51 INFO - Return code: 0 07:58:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26c2fbdfce8289d1251c41a3f3ec2dbccbbb3e332d11fa590989840030bf08a3e0accdfdff0d67a6b808f2828e490d2ee540063766009f1635f66c7917657776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52bd594a80e3b6e87eefe917dd21682389c2cd136c1570a52479c85d8b7de9bbd40e4ba422a4a4c58d04b8c46334e24047e8809496ef21b282c61e87b8f8bf22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f46f5c5e96ee36e7dffba731cde963282441798544e5c936a2d6e998ad678ec66664f28ba67d04dd934e45bd1ff7d0418555acdbb238b3be2fbf5351f1b6e0f"} 07:58:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:51 INFO - Contents: 07:58:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26c2fbdfce8289d1251c41a3f3ec2dbccbbb3e332d11fa590989840030bf08a3e0accdfdff0d67a6b808f2828e490d2ee540063766009f1635f66c7917657776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52bd594a80e3b6e87eefe917dd21682389c2cd136c1570a52479c85d8b7de9bbd40e4ba422a4a4c58d04b8c46334e24047e8809496ef21b282c61e87b8f8bf22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f46f5c5e96ee36e7dffba731cde963282441798544e5c936a2d6e998ad678ec66664f28ba67d04dd934e45bd1ff7d0418555acdbb238b3be2fbf5351f1b6e0f"} 07:58:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:51 INFO - Copying logs to upload dir... 07:58:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.280767 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-06 07:58:51.279844) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 07:58:51.282970) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26c2fbdfce8289d1251c41a3f3ec2dbccbbb3e332d11fa590989840030bf08a3e0accdfdff0d67a6b808f2828e490d2ee540063766009f1635f66c7917657776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52bd594a80e3b6e87eefe917dd21682389c2cd136c1570a52479c85d8b7de9bbd40e4ba422a4a4c58d04b8c46334e24047e8809496ef21b282c61e87b8f8bf22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f46f5c5e96ee36e7dffba731cde963282441798544e5c936a2d6e998ad678ec66664f28ba67d04dd934e45bd1ff7d0418555acdbb238b3be2fbf5351f1b6e0f"} build_url:https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011634 build_url: 'https://queue.taskcluster.net/v1/task/U9-tkmvISX-LPEe8tU_InQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26c2fbdfce8289d1251c41a3f3ec2dbccbbb3e332d11fa590989840030bf08a3e0accdfdff0d67a6b808f2828e490d2ee540063766009f1635f66c7917657776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52bd594a80e3b6e87eefe917dd21682389c2cd136c1570a52479c85d8b7de9bbd40e4ba422a4a4c58d04b8c46334e24047e8809496ef21b282c61e87b8f8bf22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f46f5c5e96ee36e7dffba731cde963282441798544e5c936a2d6e998ad678ec66664f28ba67d04dd934e45bd1ff7d0418555acdbb238b3be2fbf5351f1b6e0f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 07:58:51.309030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:58:51.309370) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481037383.539324-906137931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:58:51.397098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 07:58:51.397777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 07:58:51.398110) ========= ========= Total master_lag: 0.17 =========