builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1474899771.08 results: success (0) buildid: 20160926032449 builduid: 0061c33485e145a498684f5290f57510 revision: bc9d199d895c33f1b4984afe61ec464a43a2a61a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.076855) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.077339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.077637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.098648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.099052) ========= 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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 07:22:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-26 07:22:52 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073827 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.207137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.207463) ========= 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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018759 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.263084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.263425) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc9d199d895c33f1b4984afe61ec464a43a2a61a --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 bc9d199d895c33f1b4984afe61ec464a43a2a61a --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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 07:22:52,197 truncating revision to first 12 chars 2016-09-26 07:22:52,197 Setting DEBUG logging. 2016-09-26 07:22:52,197 attempt 1/10 2016-09-26 07:22:52,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc9d199d895c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 07:22:52,505 unpacking tar archive at: mozilla-central-bc9d199d895c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.954335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.954776) ========= script_repo_revision: bc9d199d895c33f1b4984afe61ec464a43a2a61a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.955211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.955475) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 07:22:51.969305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-09-26 07:22:51.969632) ========= /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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:22:53 INFO - MultiFileLogger online at 20160926 07:22:53 in /builds/slave/test 07:22:53 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:22:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:22:53 INFO - {'append_to_log': False, 07:22:53 INFO - 'base_work_dir': '/builds/slave/test', 07:22:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:22:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:22:53 INFO - 'branch': 'Firefox-Non-PGO', 07:22:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:22:53 INFO - 'config_files': ('talos/linux_config.py',), 07:22:53 INFO - 'default_actions': ('clobber', 07:22:53 INFO - 'read-buildbot-config', 07:22:53 INFO - 'download-and-extract', 07:22:53 INFO - 'populate-webroot', 07:22:53 INFO - 'create-virtualenv', 07:22:53 INFO - 'install', 07:22:53 INFO - 'run-tests'), 07:22:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:22:53 INFO - 'download_minidump_stackwalk': True, 07:22:53 INFO - 'download_symbols': 'ondemand', 07:22:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:22:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:22:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:22:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:22:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:22:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:22:53 INFO - 'installer_path': 'installer.exe', 07:22:53 INFO - 'log_level': 'info', 07:22:53 INFO - 'log_name': 'talos', 07:22:53 INFO - 'log_to_console': True, 07:22:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:22:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:22:53 INFO - 'opt_config_files': (), 07:22:53 INFO - 'pip_index': False, 07:22:53 INFO - 'sps_profile': False, 07:22:53 INFO - 'sps_profile_interval': 0, 07:22:53 INFO - 'suite': 'dromaeojs', 07:22:53 INFO - 'system_bits': '32', 07:22:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:22:53 INFO - 'title': 'talos-linux64-ix-043', 07:22:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:22:53 INFO - 'use_talos_json': True, 07:22:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:22:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:22:53 INFO - 'work_dir': 'build'} 07:22:53 INFO - [mozharness: 2016-09-26 14:22:53.006445Z] Running clobber step. 07:22:53 INFO - Running pre-action listener: _resource_record_pre_action 07:22:53 INFO - Running main action method: clobber 07:22:53 INFO - rmtree: /builds/slave/test/build 07:22:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:22:53 INFO - Running post-action listener: _resource_record_post_action 07:22:53 INFO - [mozharness: 2016-09-26 14:22:53.981526Z] Finished clobber step (success) 07:22:53 INFO - [mozharness: 2016-09-26 14:22:53.981626Z] Running read-buildbot-config step. 07:22:53 INFO - Running pre-action listener: _resource_record_pre_action 07:22:53 INFO - Running main action method: read_buildbot_config 07:22:53 INFO - Using buildbot properties: 07:22:53 INFO - { 07:22:53 INFO - "project": "", 07:22:53 INFO - "product": "firefox", 07:22:53 INFO - "script_repo_revision": "production", 07:22:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:22:53 INFO - "repository": "", 07:22:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:22:53 INFO - "buildid": "20160926032449", 07:22:53 INFO - "pgo_build": "False", 07:22:53 INFO - "basedir": "/builds/slave/test", 07:22:53 INFO - "buildnumber": 649, 07:22:53 INFO - "slavename": "talos-linux64-ix-043", 07:22:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:22:53 INFO - "platform": "ubuntu64_hw", 07:22:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:22:53 INFO - "branch": "mozilla-central", 07:22:53 INFO - "repo_path": "mozilla-central", 07:22:53 INFO - "revision": "bc9d199d895c33f1b4984afe61ec464a43a2a61a", 07:22:53 INFO - "stage_platform": "linux64", 07:22:53 INFO - "builduid": "0061c33485e145a498684f5290f57510", 07:22:53 INFO - "slavebuilddir": "test" 07:22:53 INFO - } 07:22:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:22:53 INFO - Running post-action listener: _resource_record_post_action 07:22:53 INFO - [mozharness: 2016-09-26 14:22:53.984031Z] Finished read-buildbot-config step (success) 07:22:53 INFO - [mozharness: 2016-09-26 14:22:53.984119Z] Running download-and-extract step. 07:22:53 INFO - Running pre-action listener: _resource_record_pre_action 07:22:53 INFO - Running main action method: download_and_extract 07:22:53 INFO - mkdir: /builds/slave/test/build/tests 07:22:53 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:22:53 INFO - trying https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:22:54 INFO - Downloaded 1361 bytes. 07:22:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:22:54 INFO - Using the following test package requirements: 07:22:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:22:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:22:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'jsshell-linux-x86_64.zip'], 07:22:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:22:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:22:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:22:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:22:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:22:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:22:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:22:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:22:54 INFO - Fetch https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:22:55 INFO - Expected file size: 20376931 07:22:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:22:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:22:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:22:59 INFO - Fetch https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:22:59 INFO - Expected file size: 20376931 07:23:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:23:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:23:04 INFO - Fetch https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:23:05 INFO - Expected file size: 14414059 07:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:05 INFO - trying https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:05 INFO - Downloading https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:23:08 INFO - Downloaded 55729778 bytes. 07:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:08 INFO - mkdir: /builds/slave/test/properties 07:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:08 INFO - Contents: 07:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:09 INFO - Running post-action listener: _resource_record_post_action 07:23:09 INFO - Running post-action listener: set_extra_try_arguments 07:23:09 INFO - [mozharness: 2016-09-26 14:23:09.623531Z] Finished download-and-extract step (success) 07:23:09 INFO - [mozharness: 2016-09-26 14:23:09.623758Z] Running populate-webroot step. 07:23:09 INFO - Running pre-action listener: _resource_record_pre_action 07:23:09 INFO - Running main action method: populate_webroot 07:23:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:09 INFO - '--tppagecycles', 07:23:09 INFO - '7'], 07:23:09 INFO - 'tests': ['tsvgm']}}, 07:23:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['damp', 'tps']}, 07:23:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'tests': ['damp', 'tps']}, 07:23:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['dromaeo_dom']}, 07:23:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['basic_compositor_video']}, 07:23:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['a11yr', 07:23:09 INFO - 'ts_paint', 07:23:09 INFO - 'tpaint', 07:23:09 INFO - 'sessionrestore', 07:23:09 INFO - 'sessionrestore_no_auto_restore', 07:23:09 INFO - 'tabpaint']}, 07:23:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['tsvgx', 07:23:09 INFO - 'tsvgr_opacity', 07:23:09 INFO - 'tart', 07:23:09 INFO - 'tscrollx', 07:23:09 INFO - 'cart']}, 07:23:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:09 INFO - 'tsvgr_opacity', 07:23:09 INFO - 'tart', 07:23:09 INFO - 'tscrollx', 07:23:09 INFO - 'cart']}, 07:23:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'talos_options': ['--disable-e10s'], 07:23:09 INFO - 'tests': ['tp5o']}, 07:23:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'tests': ['tp5o']}, 07:23:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'talos_options': ['--disable-e10s', 07:23:09 INFO - '--xperf_path', 07:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:09 INFO - 'tests': ['tp5n']}, 07:23:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:09 INFO - 'talos_options': ['--xperf_path', 07:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:09 INFO - 'tests': ['tp5n']}}, 07:23:09 INFO - 'talos.zip': {'path': '', 07:23:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:09 INFO - Running post-action listener: _resource_record_post_action 07:23:09 INFO - [mozharness: 2016-09-26 14:23:09.642544Z] Finished populate-webroot step (success) 07:23:09 INFO - [mozharness: 2016-09-26 14:23:09.642632Z] Running create-virtualenv step. 07:23:09 INFO - Running pre-action listener: _resource_record_pre_action 07:23:09 INFO - Running main action method: create_virtualenv 07:23:09 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:09 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:23:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:09 INFO - Using real prefix '/usr' 07:23:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:12 INFO - Installing pip.................done. 07:23:12 INFO - Return code: 0 07:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:23:12 INFO - Reading from file tmpfile_stdout 07:23:12 INFO - Output received: 07:23:12 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:23:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:23:12 INFO - Using env: {'DISPLAY': ':0', 07:23:12 INFO - 'HOME': '/home/cltbld', 07:23:12 INFO - 'LANG': 'en_US.UTF-8', 07:23:12 INFO - 'LANGUAGE': 'en_US:en', 07:23:12 INFO - 'LOGNAME': 'cltbld', 07:23:12 INFO - 'MAIL': '/var/mail/cltbld', 07:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:12 INFO - 'MOZ_NO_REMOTE': '1', 07:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:12 INFO - 'NO_EM_RESTART': '1', 07:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:12 INFO - 'PWD': '/builds/slave/test', 07:23:12 INFO - 'SHELL': '/bin/bash', 07:23:12 INFO - 'SHLVL': '1', 07:23:12 INFO - 'TERM': 'linux', 07:23:12 INFO - 'TMOUT': '86400', 07:23:12 INFO - 'USER': 'cltbld', 07:23:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:12 INFO - '_': '/tools/buildbot/bin/python'} 07:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:12 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:23:12 INFO - Cleaning up... 07:23:12 INFO - Return code: 0 07:23:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:23:12 INFO - Using env: {'DISPLAY': ':0', 07:23:12 INFO - 'HOME': '/home/cltbld', 07:23:12 INFO - 'LANG': 'en_US.UTF-8', 07:23:12 INFO - 'LANGUAGE': 'en_US:en', 07:23:12 INFO - 'LOGNAME': 'cltbld', 07:23:12 INFO - 'MAIL': '/var/mail/cltbld', 07:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:12 INFO - 'MOZ_NO_REMOTE': '1', 07:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:12 INFO - 'NO_EM_RESTART': '1', 07:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:12 INFO - 'PWD': '/builds/slave/test', 07:23:12 INFO - 'SHELL': '/bin/bash', 07:23:12 INFO - 'SHLVL': '1', 07:23:12 INFO - 'TERM': 'linux', 07:23:12 INFO - 'TMOUT': '86400', 07:23:12 INFO - 'USER': 'cltbld', 07:23:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:12 INFO - '_': '/tools/buildbot/bin/python'} 07:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:12 INFO - Downloading/unpacking psutil>=3.1.1 07:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:14 INFO - Installing collected packages: psutil 07:23:14 INFO - Running setup.py install for psutil 07:23:14 INFO - building 'psutil._psutil_linux' extension 07:23:14 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:23:15 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:23:15 INFO - building 'psutil._psutil_posix' extension 07:23:15 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:23:15 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:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:15 INFO - Successfully installed psutil 07:23:15 INFO - Cleaning up... 07:23:15 INFO - Return code: 0 07:23:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23: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:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:15 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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:15 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:23:15 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:23:15 INFO - Using env: {'DISPLAY': ':0', 07:23:15 INFO - 'HOME': '/home/cltbld', 07:23:15 INFO - 'LANG': 'en_US.UTF-8', 07:23:15 INFO - 'LANGUAGE': 'en_US:en', 07:23:15 INFO - 'LOGNAME': 'cltbld', 07:23:15 INFO - 'MAIL': '/var/mail/cltbld', 07:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:15 INFO - 'MOZ_NO_REMOTE': '1', 07:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:15 INFO - 'NO_EM_RESTART': '1', 07:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:15 INFO - 'PWD': '/builds/slave/test', 07:23:15 INFO - 'SHELL': '/bin/bash', 07:23:15 INFO - 'SHLVL': '1', 07:23:15 INFO - 'TERM': 'linux', 07:23:15 INFO - 'TMOUT': '86400', 07:23:15 INFO - 'USER': 'cltbld', 07:23:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:15 INFO - '_': '/tools/buildbot/bin/python'} 07:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:18 INFO - Installing collected packages: mozsystemmonitor 07:23:18 INFO - Running setup.py install for mozsystemmonitor 07:23:18 INFO - Successfully installed mozsystemmonitor 07:23:18 INFO - Cleaning up... 07:23:18 INFO - Return code: 0 07:23:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:23:18 INFO - Using env: {'DISPLAY': ':0', 07:23:18 INFO - 'HOME': '/home/cltbld', 07:23:18 INFO - 'LANG': 'en_US.UTF-8', 07:23:18 INFO - 'LANGUAGE': 'en_US:en', 07:23:18 INFO - 'LOGNAME': 'cltbld', 07:23:18 INFO - 'MAIL': '/var/mail/cltbld', 07:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:18 INFO - 'MOZ_NO_REMOTE': '1', 07:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:18 INFO - 'NO_EM_RESTART': '1', 07:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:18 INFO - 'PWD': '/builds/slave/test', 07:23:18 INFO - 'SHELL': '/bin/bash', 07:23:18 INFO - 'SHLVL': '1', 07:23:18 INFO - 'TERM': 'linux', 07:23:18 INFO - 'TMOUT': '86400', 07:23:18 INFO - 'USER': 'cltbld', 07:23:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:18 INFO - '_': '/tools/buildbot/bin/python'} 07:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:18 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:18 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:23:18 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:23:18 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:23:18 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:23:18 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:23:18 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:23:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23:20 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:23:20 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:23:20 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:23:20 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:23:20 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:23:20 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:23:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:23:21 INFO - warning: no files found matching '*.txt' 07:23:21 INFO - no previously-included directories found matching 'build' 07:23:21 INFO - no previously-included directories found matching 'dist' 07:23:21 INFO - no previously-included directories found matching '.git*' 07:23:21 INFO - Installing collected packages: jsonschema, functools32 07:23:21 INFO - Running setup.py install for functools32 07:23:21 INFO - warning: no files found matching '*.txt' 07:23:21 INFO - no previously-included directories found matching 'build' 07:23:21 INFO - no previously-included directories found matching 'dist' 07:23:21 INFO - no previously-included directories found matching '.git*' 07:23:21 INFO - Successfully installed jsonschema functools32 07:23:21 INFO - Cleaning up... 07:23:21 INFO - Return code: 0 07:23:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:23: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:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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', '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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:23: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 functools32==3.2.3-2 07:23:21 INFO - Using env: {'DISPLAY': ':0', 07:23:21 INFO - 'HOME': '/home/cltbld', 07:23:21 INFO - 'LANG': 'en_US.UTF-8', 07:23:21 INFO - 'LANGUAGE': 'en_US:en', 07:23:21 INFO - 'LOGNAME': 'cltbld', 07:23:21 INFO - 'MAIL': '/var/mail/cltbld', 07:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:21 INFO - 'MOZ_NO_REMOTE': '1', 07:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:21 INFO - 'NO_EM_RESTART': '1', 07:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:21 INFO - 'PWD': '/builds/slave/test', 07:23:21 INFO - 'SHELL': '/bin/bash', 07:23:21 INFO - 'SHLVL': '1', 07:23:21 INFO - 'TERM': 'linux', 07:23:21 INFO - 'TMOUT': '86400', 07:23:21 INFO - 'USER': 'cltbld', 07:23:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:21 INFO - '_': '/tools/buildbot/bin/python'} 07:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:23:21 INFO - Cleaning up... 07:23:21 INFO - Return code: 0 07:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:23: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:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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', '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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:23: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 blobuploader==1.2.4 07:23:21 INFO - Using env: {'DISPLAY': ':0', 07:23:21 INFO - 'HOME': '/home/cltbld', 07:23:21 INFO - 'LANG': 'en_US.UTF-8', 07:23:21 INFO - 'LANGUAGE': 'en_US:en', 07:23:21 INFO - 'LOGNAME': 'cltbld', 07:23:21 INFO - 'MAIL': '/var/mail/cltbld', 07:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:21 INFO - 'MOZ_NO_REMOTE': '1', 07:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:21 INFO - 'NO_EM_RESTART': '1', 07:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:21 INFO - 'PWD': '/builds/slave/test', 07:23:21 INFO - 'SHELL': '/bin/bash', 07:23:21 INFO - 'SHLVL': '1', 07:23:21 INFO - 'TERM': 'linux', 07:23:21 INFO - 'TMOUT': '86400', 07:23:21 INFO - 'USER': 'cltbld', 07:23:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:21 INFO - '_': '/tools/buildbot/bin/python'} 07:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:23: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:23: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:23: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:23: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:23: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:23: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:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 07:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:23: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:23: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:23: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:23: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:23: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:23: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:23:24 INFO - Downloading docopt-0.6.1.tar.gz 07:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:23:24 INFO - Running setup.py install for blobuploader 07:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:23:24 INFO - Running setup.py install for requests 07:23:24 INFO - Running setup.py install for docopt 07:23:24 INFO - Successfully installed blobuploader requests docopt 07:23:24 INFO - Cleaning up... 07:23:25 INFO - Return code: 0 07:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:25 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:23:25 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:23:25 INFO - Using env: {'DISPLAY': ':0', 07:23:25 INFO - 'HOME': '/home/cltbld', 07:23:25 INFO - 'LANG': 'en_US.UTF-8', 07:23:25 INFO - 'LANGUAGE': 'en_US:en', 07:23:25 INFO - 'LOGNAME': 'cltbld', 07:23:25 INFO - 'MAIL': '/var/mail/cltbld', 07:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:25 INFO - 'MOZ_NO_REMOTE': '1', 07:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:25 INFO - 'NO_EM_RESTART': '1', 07:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:25 INFO - 'PWD': '/builds/slave/test', 07:23:25 INFO - 'SHELL': '/bin/bash', 07:23:25 INFO - 'SHLVL': '1', 07:23:25 INFO - 'TERM': 'linux', 07:23:25 INFO - 'TMOUT': '86400', 07:23:25 INFO - 'USER': 'cltbld', 07:23:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:25 INFO - '_': '/tools/buildbot/bin/python'} 07:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:25 INFO - Running setup.py (path:/tmp/pip-DAFS1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:25 INFO - Running setup.py (path:/tmp/pip-Cu0J6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:25 INFO - Running setup.py (path:/tmp/pip-22hMWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:25 INFO - Running setup.py (path:/tmp/pip-CkdHxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:25 INFO - Running setup.py (path:/tmp/pip-rUD_Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:25 INFO - Running setup.py (path:/tmp/pip-KKK575-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:25 INFO - Running setup.py (path:/tmp/pip-6vVydf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:25 INFO - Running setup.py (path:/tmp/pip-91MlJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:25 INFO - Running setup.py (path:/tmp/pip-nHUXBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:25 INFO - Running setup.py (path:/tmp/pip-8Ib31y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:25 INFO - Running setup.py (path:/tmp/pip-WdS3qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:26 INFO - Running setup.py (path:/tmp/pip-jPWZs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:26 INFO - Running setup.py (path:/tmp/pip-ARF5rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:26 INFO - Running setup.py (path:/tmp/pip-xdsFq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:26 INFO - Running setup.py (path:/tmp/pip-3bp3ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:26 INFO - Running setup.py (path:/tmp/pip-kPPT6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:26 INFO - Running setup.py (path:/tmp/pip-gHHqlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:23:26 INFO - Running setup.py install for manifestparser 07:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:23:26 INFO - Running setup.py install for mozcrash 07:23:26 INFO - Running setup.py install for mozdebug 07:23:26 INFO - Running setup.py install for mozdevice 07:23:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:23:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:23:26 INFO - Running setup.py install for mozfile 07:23:26 INFO - Running setup.py install for mozhttpd 07:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozinfo 07:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozInstall 07:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozleak 07:23:27 INFO - Running setup.py install for mozlog 07:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for moznetwork 07:23:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozprocess 07:23:27 INFO - Running setup.py install for mozprofile 07:23:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozrunner 07:23:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozscreenshot 07:23:28 INFO - Running setup.py install for moztest 07:23:28 INFO - Running setup.py install for mozversion 07:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:23:28 INFO - Cleaning up... 07:23:28 INFO - Return code: 0 07:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23: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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:28 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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:28 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:23:28 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:23:28 INFO - Using env: {'DISPLAY': ':0', 07:23:28 INFO - 'HOME': '/home/cltbld', 07:23:28 INFO - 'LANG': 'en_US.UTF-8', 07:23:28 INFO - 'LANGUAGE': 'en_US:en', 07:23:28 INFO - 'LOGNAME': 'cltbld', 07:23:28 INFO - 'MAIL': '/var/mail/cltbld', 07:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:28 INFO - 'MOZ_NO_REMOTE': '1', 07:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:28 INFO - 'NO_EM_RESTART': '1', 07:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:28 INFO - 'PWD': '/builds/slave/test', 07:23:28 INFO - 'SHELL': '/bin/bash', 07:23:28 INFO - 'SHLVL': '1', 07:23:28 INFO - 'TERM': 'linux', 07:23:28 INFO - 'TMOUT': '86400', 07:23:28 INFO - 'USER': 'cltbld', 07:23:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:28 INFO - '_': '/tools/buildbot/bin/python'} 07:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:28 INFO - Running setup.py (path:/tmp/pip-uM3MZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:28 INFO - Running setup.py (path:/tmp/pip-QBvYgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:28 INFO - Running setup.py (path:/tmp/pip-o89qQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:28 INFO - Running setup.py (path:/tmp/pip-_z7Gb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:28 INFO - Running setup.py (path:/tmp/pip-Q5UcnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:28 INFO - Running setup.py (path:/tmp/pip-PH6JZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:28 INFO - Running setup.py (path:/tmp/pip-Fz91OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:28 INFO - Running setup.py (path:/tmp/pip-wXVgNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:29 INFO - Running setup.py (path:/tmp/pip-brwDtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:29 INFO - Running setup.py (path:/tmp/pip-85Rvgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:29 INFO - Running setup.py (path:/tmp/pip-9otFnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:29 INFO - Running setup.py (path:/tmp/pip-hxPm67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:29 INFO - Running setup.py (path:/tmp/pip-1BQncK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:29 INFO - Running setup.py (path:/tmp/pip-i40xii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:29 INFO - Running setup.py (path:/tmp/pip-qgHxEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:29 INFO - Running setup.py (path:/tmp/pip-XNC0bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:29 INFO - Running setup.py (path:/tmp/pip-3nSey4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:29 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:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:29 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:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:23: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:23: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:23: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:23: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:23: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:23: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:23:31 INFO - Downloading blessings-1.6.tar.gz 07:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:23:31 INFO - Installing collected packages: blessings 07:23:31 INFO - Running setup.py install for blessings 07:23:31 INFO - Successfully installed blessings 07:23:31 INFO - Cleaning up... 07:23:32 INFO - Return code: 0 07:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:32 INFO - Reading from file tmpfile_stdout 07:23:32 INFO - Current package versions: 07:23:32 INFO - argparse == 1.2.1 07:23:32 INFO - blessings == 1.6 07:23:32 INFO - blobuploader == 1.2.4 07:23:32 INFO - docopt == 0.6.1 07:23:32 INFO - functools32 == 3.2.3-2 07:23:32 INFO - jsonschema == 2.5.1 07:23:32 INFO - manifestparser == 1.1 07:23:32 INFO - mozInstall == 1.12 07:23:32 INFO - mozcrash == 0.17 07:23:32 INFO - mozdebug == 0.1 07:23:32 INFO - mozdevice == 0.48 07:23:32 INFO - mozfile == 1.2 07:23:32 INFO - mozhttpd == 0.7 07:23:32 INFO - mozinfo == 0.9 07:23:32 INFO - mozleak == 0.1 07:23:32 INFO - mozlog == 3.4 07:23:32 INFO - moznetwork == 0.27 07:23:32 INFO - mozprocess == 0.23 07:23:32 INFO - mozprofile == 0.28 07:23:32 INFO - mozrunner == 6.12 07:23:32 INFO - mozscreenshot == 0.1 07:23:32 INFO - mozsystemmonitor == 0.3 07:23:32 INFO - moztest == 0.7 07:23:32 INFO - mozversion == 1.4 07:23:32 INFO - psutil == 3.1.1 07:23:32 INFO - requests == 1.2.3 07:23:32 INFO - wsgiref == 0.1.2 07:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23: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:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 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 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:32 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:23:32 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:23:32 INFO - Using env: {'DISPLAY': ':0', 07:23:32 INFO - 'HOME': '/home/cltbld', 07:23:32 INFO - 'LANG': 'en_US.UTF-8', 07:23:32 INFO - 'LANGUAGE': 'en_US:en', 07:23:32 INFO - 'LOGNAME': 'cltbld', 07:23:32 INFO - 'MAIL': '/var/mail/cltbld', 07:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:32 INFO - 'MOZ_NO_REMOTE': '1', 07:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:32 INFO - 'NO_EM_RESTART': '1', 07:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:32 INFO - 'PWD': '/builds/slave/test', 07:23:32 INFO - 'SHELL': '/bin/bash', 07:23:32 INFO - 'SHLVL': '1', 07:23:32 INFO - 'TERM': 'linux', 07:23:32 INFO - 'TMOUT': '86400', 07:23:32 INFO - 'USER': 'cltbld', 07:23:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:32 INFO - '_': '/tools/buildbot/bin/python'} 07:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 INFO - Cleaning up... 07:23:32 INFO - Return code: 0 07:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:23: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:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a36ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', '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:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:23:32 INFO - Using env: {'DISPLAY': ':0', 07:23:32 INFO - 'HOME': '/home/cltbld', 07:23:32 INFO - 'LANG': 'en_US.UTF-8', 07:23:32 INFO - 'LANGUAGE': 'en_US:en', 07:23:32 INFO - 'LOGNAME': 'cltbld', 07:23:32 INFO - 'MAIL': '/var/mail/cltbld', 07:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:32 INFO - 'MOZ_NO_REMOTE': '1', 07:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:32 INFO - 'NO_EM_RESTART': '1', 07:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:32 INFO - 'PWD': '/builds/slave/test', 07:23:32 INFO - 'SHELL': '/bin/bash', 07:23:32 INFO - 'SHLVL': '1', 07:23:32 INFO - 'TERM': 'linux', 07:23:32 INFO - 'TMOUT': '86400', 07:23:32 INFO - 'USER': 'cltbld', 07:23:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:32 INFO - '_': '/tools/buildbot/bin/python'} 07:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:23:32 INFO - Cleaning up... 07:23:32 INFO - Return code: 0 07:23:32 INFO - Running post-action listener: _resource_record_post_action 07:23:32 INFO - Running post-action listener: _start_resource_monitoring 07:23:32 INFO - Starting resource monitoring. 07:23:32 INFO - [mozharness: 2016-09-26 14:23:32.798013Z] Finished create-virtualenv step (success) 07:23:32 INFO - [mozharness: 2016-09-26 14:23:32.798514Z] Running install step. 07:23:32 INFO - Running pre-action listener: _resource_record_pre_action 07:23:32 INFO - Running main action method: install 07:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:33 INFO - Reading from file tmpfile_stdout 07:23:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:23:33 INFO - Reading from file tmpfile_stdout 07:23:33 INFO - Output received: 07:23:33 INFO - Usage: mozinstall [options] installer 07:23:33 INFO - Options: 07:23:33 INFO - -h, --help show this help message and exit 07:23:33 INFO - -d DEST, --destination=DEST 07:23:33 INFO - Directory to install application into. [default: 07:23:33 INFO - "/builds/slave/test"] 07:23:33 INFO - --app=APP Application being installed. [default: firefox] 07:23:33 INFO - mkdir: /builds/slave/test/build/application 07:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:23:49 INFO - Reading from file tmpfile_stdout 07:23:49 INFO - Output received: 07:23:49 INFO - /builds/slave/test/build/application/firefox/firefox 07:23:49 INFO - Running post-action listener: _resource_record_post_action 07:23:49 INFO - [mozharness: 2016-09-26 14:23:49.204271Z] Finished install step (success) 07:23:49 INFO - [mozharness: 2016-09-26 14:23:49.204584Z] Running run-tests step. 07:23:49 INFO - Running pre-action listener: _resource_record_pre_action 07:23:49 INFO - Running main action method: run_tests 07:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:49 INFO - Python 2.7.3 07:23:49 INFO - Return code: 0 07:23:49 INFO - grabbing minidump binary from tooltool 07:23:49 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:23:49 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 0xce2f60>, '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 0xce3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:49 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:23:49 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:23:49 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:23:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:49 INFO - Return code: 0 07:23:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:23:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:23:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:49 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/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:23:49 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/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:23:49 INFO - Using env: {'DISPLAY': ':0', 07:23:49 INFO - 'HOME': '/home/cltbld', 07:23:49 INFO - 'LANG': 'en_US.UTF-8', 07:23:49 INFO - 'LANGUAGE': 'en_US:en', 07:23:49 INFO - 'LOGNAME': 'cltbld', 07:23:49 INFO - 'MAIL': '/var/mail/cltbld', 07:23:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:49 INFO - 'MOZ_NO_REMOTE': '1', 07:23:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:49 INFO - 'NO_EM_RESTART': '1', 07:23:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:49 INFO - 'PWD': '/builds/slave/test', 07:23:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:49 INFO - 'SHELL': '/bin/bash', 07:23:49 INFO - 'SHLVL': '1', 07:23:49 INFO - 'TERM': 'linux', 07:23:49 INFO - 'TMOUT': '86400', 07:23:49 INFO - 'USER': 'cltbld', 07:23:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474897884.547562-654966778', 07:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:49 INFO - '_': '/tools/buildbot/bin/python'} 07:23:49 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/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:23:49 INFO - mozversion application_buildid: 20160926032449 07:23:49 INFO - mozversion application_changeset: bc9d199d895c33f1b4984afe61ec464a43a2a61a 07:23:49 INFO - mozversion application_display_name: Nightly 07:23:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:49 INFO - mozversion application_name: Firefox 07:23:49 INFO - mozversion application_remotingname: firefox 07:23:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:23:49 INFO - mozversion application_vendor: Mozilla 07:23:49 INFO - mozversion application_version: 52.0a1 07:23:49 INFO - mozversion platform_buildid: 20160926032449 07:23:49 INFO - mozversion platform_changeset: bc9d199d895c33f1b4984afe61ec464a43a2a61a 07:23:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:23:49 INFO - mozversion platform_version: 52.0a1 07:23:49 INFO - using testdate: 1474899829 07:23:49 INFO - actual date: 1474899829 07:23:49 INFO - starting webserver on 'localhost:38873' 07:23:49 INFO - SUITE-START | Running 2 tests 07:23:49 INFO - TEST-START | dromaeo_css 07:23:49 INFO - operating with platform_type : linux_ 07:23:49 INFO - Initialising browser for dromaeo_css test... 07:23:49 INFO - TEST-INFO | started process 13150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23xhxf/profile http://localhost:38873/getInfo.html) 07:23:54 INFO - PROCESS | 13150 | __metrics Screen width/height:1600/1200 07:23:54 INFO - PROCESS | 13150 | colorDepth:24 07:23:54 INFO - PROCESS | 13150 | Browser inner width/height: 1024/697 07:23:54 INFO - PROCESS | 13150 | __metrics 07:23:54 INFO - PROCESS | 13150 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:23:54 INFO - PROCESS | 13150 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:55 INFO - PROCESS | 13150 | console.error: PushService: 07:23:55 INFO - PROCESS | 13150 | stateChangeProcessEnqueue: Error transitioning state 07:23:55 INFO - PROCESS | 13150 | UnknownError 07:23:56 INFO - TEST-INFO | 13150: exit 0 07:23:56 INFO - Browser initialized. 07:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 07:23:56 INFO - TEST-INFO | started process 13233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23xhxf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:08 INFO - PROCESS | 13233 | RSS: Main: 175136768 07:24:08 INFO - PROCESS | 13233 | 07:24:59 INFO - PROCESS | 13233 | 1474899899395 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:27:13 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38873/tests/dromaeo/cssquery-ext.html) 07:27:14 INFO - PROCESS | 13233 | RSS: Main: 255176704 07:27:14 INFO - PROCESS | 13233 | 07:30:17 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-ext.html (next: http://localhost:38873/tests/dromaeo/cssquery-jquery.html) 07:30:17 INFO - PROCESS | 13233 | RSS: Main: 268992512 07:30:17 INFO - PROCESS | 13233 | 07:33:20 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38873/tests/dromaeo/cssquery-mootools.html) 07:33:20 INFO - PROCESS | 13233 | RSS: Main: 214376448 07:33:20 INFO - PROCESS | 13233 | 07:36:22 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38873/tests/dromaeo/cssquery-prototype.html) 07:36:23 INFO - PROCESS | 13233 | RSS: Main: 240009216 07:36:23 INFO - PROCESS | 13233 | 07:39:26 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38873/tests/dromaeo/cssquery-yui.html) 07:39:27 INFO - PROCESS | 13233 | RSS: Main: 214822912 07:39:27 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:38873/tests/dromaeo/cssquery-yui.html (next: http://localhost:38873/tests/dromaeo/cssquery-dojo.html) 07:42:30 INFO - PROCESS | 13233 | RSS: Main: 305713152 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | __start_tp_report 07:42:30 INFO - PROCESS | 13233 | _x_x_mozilla_page_load 07:42:30 INFO - PROCESS | 13233 | _x_x_mozilla_page_load_details 07:42:30 INFO - PROCESS | 13233 | |i|pagename|runs| 07:42:30 INFO - PROCESS | 13233 | |0;dojo.html;2571.62711406846;2607.93480162996;2636.0510216322127;2645.973540264597;2662.1614191529666;4645.256758918574;4728.621710263179;4760.928586071207;4765.594924431419;4779.904401911964;4665.370175026371;4731.101090792756;4753.287006948951;4764.428268607763;4816.458733205367;4282.528921818597;4321.373400856874;4335.197988372145;4370.1915145697985;4375.978120109411;4355.0201204729;4412.205802955466;4436.689431739779;4451.955480445203;4504.301833215857;4404.603585677304;4432.689711720181;4453.109378124372;4458.464984201884;4493.932591011121;4260.7656578888145;4271.380649805792;4304.096139810644;4329.848455304081;4330.805113769857;4233.23801715691;4236.788160591958;4241.172971270604;4349.543297953701;4392.560743925614;4693.812247510095;4703.905921881543;4712.340272361872;4721.976390118028;4780.402449693788;4894.877628059291;4896.926546101811;4951.925721114186;5036.899262014776;5059.418166910778;4955.653104282702;4965.826196083156;4967.403911530603;4970.13022721026;5021.322121513622;4634.513565524342;4645.256758918556;4645.814167433265;4647.651426143053;4666.253399456071;5007.474215207423;5012.298278241049;5060.2662613920775;5212.244224587414;5250.264962905197;4882.023595280958;4903.509649035068;4904.558589726942;4946.604271658259;4967.776450059756;4975.054739599537;4977.925331120036;4980.12847751642;4985.476524964826;5052.797888084509;4834.347363106006;4897.7795999180125;4944.975275123601;4952.529509696573;5008.474110218374;4942;4953.2570114483115;4965.602751779849;4990.675606085593;4999.725015124203;4190.790460476964;4193.643540299109;4197.202531519001;4243.851465198703;4254.489461264668;3694.833732482045;3716.591174970751;3719.3119272934596;3757.1358587524473;3791.7156213284115;4250.213710463574;4308.353746937984;4309.439772829513;4339.82640694375;4378.277584198571;5009.12340340439;5014.423341315723;5016.197408414636;5041.621878359065;5083.6187285952965;4283.207606592728;4321.006168581244;4322.178786030644;4337.436133302651;4369.213541562549;4439.200943830077;4470.731756094645;4481.887952801206;4509.571590698878;4517.728936263835;4687.69529980557;4721.622270218443;4723.716577005391;4760.690555113906;4774.665773395829;5018.1469150245275;5021.4225364083595;5031.345925029869;5031.396232452129;5086.821961231339;4594.678372513892;4614.700044497097;4713.528647135397;4720.858374248778;4781.282807578891;4846.975765121152;4897.632677549269;4903.6077113831525;4905.386826646669;4967.329410529533;4980.978899325557;4984.302197692254;4990.72551009698;4991.725455100004;5057.494250574913;4770.212914869007;4857.441394239567;4859.829905953275;4878.536539028786;4911.386076740408;4808.182608956416;4822.7829747660735;4828.493008234085;4863.3434486343895;4933.55597996182;4771.856844294677;4783.234682450791;4786.976065119791;4810.8797280068275;4832.226843704991;4844.32179494864;4892.902141957212;4903.26451032348;4912.606991440604;4927.827526036572;4769.61843052548;4785.234362501983;4794.472608013186;4833.951660483491;4848.393950756155 07:42:30 INFO - PROCESS | 13233 | |1;ext.html;531.8431062836465;565.790657456741;568.7184843502467;576.8010036537393;581.6742624130486;27057;30024.54963175554;41612.791936040274;42841.785791071;42875.14249715004;38366.61633383665;38832.417513737244;38842.61157388432;38851.61148388515;38852.41721374181;7237.9276207238045;7630.694772209105;7812.453128281023;7816.921830781705;7824.921750782505;7199.424046076328;7469.626518674072;7488.213737557559;7490.363319117854;9713.222942164644;9762;10136.138428233573;10159.187265018782;10173.94913025434;10177.898221017806;9966.352187107852;10035.498225088717;10055.69832905014;10056;10056.396616202977;9855.211583073336;9918.90081099187;9920.851187232198;9926.553305101288;9928;37253.627463725556;37567.24865502702;37581.812090939646;37591.62408375909;37645.81177094125;3007.533832255982;3048.3903219356;3072.1858707442548;3105.922351941197;3276.5576647152566;27590.448191036267;28006.5799013015;28134.71865281362;28552.857235713895;29621.407571848657;2960.319126600872;3066.47869862124;3109.253779093024;3163.715265626082;3192.2657788708725;247057;248324;249661;250364;250494;30530;31132.066038018897;31194.376112477625;49047;49344.25983610249;32264.83867580647;32534.186645334055;32668.67331326656;32700.509492357633;32739.181520462178;12663.240205587694;12874.420651070724;12875.420606072748;12879.16285441462;12882.355882205853;9811.460369679593;9913.752156196153;9924.950375248078;9925.60297588103;9932.205423566098;7093.751718689821;7202.279772022861;7413;7605.011348524767;7664.233576642291;3020.592220050265;3039.452898478295;3040.619922509686;3046.3754930239247;3070.9846450767604;847.3856454070749;918.2011649864527;953.6328513522344;1002.6941782756184;1017.6946915925341;26940.191794246202;27531.724682753316;27664.723352766618;27847.443051138864;28062;880.5905254056894;906.211595911548;933.0576118120747;971.9562619682131;1013.3312014070679;14278.214698191492;14672.949029914542;14733.336999835034;14870.479533216285;14923.328450219766;381840;385644;385742;386377;387266;41852;42663.57336426658;45345;46655.766721166176;47503.287450688265;1150.654803558929;1153.0890596428894;1161.384466232898;1170.9941450292695;1179.2393905930799;26755;28140.296492587848;28854.42291154207;29197.562036569892;29265.85367073151;40928;40989.38515922204;41276.58723412848;41458.170836583704;41477.377839333036;359319;371996;373340;561877;561902;36791;37361.25277494489;37476.625233748404;37657.81171094127;37905;41168.954329922635;41338.58661413468;41437;41723.58276417318;42060.36909446299;34977.475337869444;34995.65004349924;35629.82185089058;35743.285134296646;36007.45988810118;35390;35496.82251588725;35828;35842.82078589591;35871;34029.82985085059;34557.481637775956;34562.48156277708;34659.30681386409;35362;29965.400691985604;32072.198195045312;32280.83859580781;32398.352032958737;32529.837350813094;24793.256202313958;24910.252692419257;25207.11775087863;25343.74656253414;25545.744542554337 07:42:30 INFO - PROCESS | 13233 | |2;jquery.html;355.98754043608477;367.6323676323676;374.68152070739865;376.96607305342513;394.5758309816946;12401.255924644516;15283.847161528382;16007.119608421532;16412;17397.304107835673;15577.376904923789;16596.585085372873;16910.408135715254;17069.658606827856;17239;4892.26616007599;5090.24386586627;5242.659227150242;5473.808416705416;5528.944710552903;3459.4983727359518;3617.94573081404;5493.313335833021;5526.668399896019;5531.834044978637;3581.212133330663;3582.897582268314;3620.9094772630633;3647.689946354563;3751.1934933989187;5999.760009599632;6092.756289748405;6094.390560943914;6097.786577469789;6098.14625952367;5230.607704422146;5288.338957630296;5331.333583302087;5331.893362132736;5387.568994480472;12467.189632673848;12679.619611411672;12693.682657933625;12765.808512872314;20696.068676909574;1827.7075667893207;1854.156358856717;1971.546544294806;1999.8100180482832;2313.849599776026;9225.677101301422;9512.762180945463;9574.281928855295;9794.755131121708;10631.989960953697;1648.9752653710204;1679.8404151605578;1720.5096547484031;1798.8830726002768;1804.2061492943062;60754.39245607576;64251.357486425004;67907.66046169787;70069.64965175193;73170;9422.246220302359;9668.178204852526;9925.950370248247;9959.153471954965;10027.147692446079;13763.862361376257;13771.173729576058;13771.380287887068;13773.311334433238;13773.38019789112;6832.111825462658;6848.075509806113;6903.482238832108;7115.964420177866;7183.281671832775;6317.652529110943;6766.966165169143;6795.3204679531655;6999.405050570758;7028.683709233097;4245.766482843412;4343.4136391586735;4346.326319420495;4381.474223093185;4411.2941929291155;1773.4945540521148;1790.185465613143;1813.5012871460453;1829.2408650409932;1901.4580844459263;735.433716038658;789.6407134753788;838.279079991207;914.9130832570895;925.629748100765;15585.922070389803;16420.83579164217;16814.66370672604;16939.322427103023;17165;908.8409528332515;909.0500427053745;910.1171863292595;923.2936803345447;931.464407965409;8947.418417802823;9410.71767846952;9454.290928180413;9496.192823609932;9546.761330966643;339329;340138;342183;342266;351374;73639.63180184065;75106.24893751102;75685.24314756892;77350;78752;864.5849992003873;870.2428886868338;888.395890794266;894.1952242981368;894.4543828264754;13852.376643050886;14126.78809817833;14208;14330.355134018786;14906.105633662015;37171.628283717895;39431.60568394394;39958.400623990085;40050.1989960205;40810.18379632331;47516.2872556905;48672;51903.48096518986;53168.734156328974;53180.73409632927;7571.924280757342;7635.732749353746;7662.693492260247;7718.189590092959;7719.459637825298;8949.59726812308;11526.711832204262;11644.417779110841;11790.705232369259;12070.879291207328;10036.698899032748;10121.848172277274;10454.215933804842;10652.57389704403;10723.356598604109;10205.948970255102;10324.741881453023;10326.793464130526;10464.267501275142;10529.789404212026;9792.657256995972;10112.342697724624;10159.644412445528;10278.640247591298;10742.677719668422;7768.7669369918995;7912.248336408032;7979.760607181794;7986.640601172845;8195.139510351328;9874.456904870302;9892.604295828087;10190.490475476048;10365.274430789772;10460.058594726512 07:42:30 INFO - PROCESS | 13233 | |3;mootools.html;1249.6376050945225;1345.9528916487925;1378.3728403576374;1405.761020626494;1672.5426737743912;7026.964865175673;7581.469297149201;7826.530408175499;7827.960860195705;8076.232757888006;7935.087464941534;8010.439269251155;8014.879776803353;8016.238457346542;8018.238267364591;2175.5866385386803;2201.0535469748;2204.1844517528457;2204.713387259654;2204.9559008819815;2127;2147.806697397234;2200.3508964855328;2204.5039866030174;2208.2712704807454;2121.9257325993594;2126.9042893069773;2132.6907598398225;2136.4552039229975;2170.9782902171014;2127.414960885761;2136.2736669532433;2139.326112274644;2143.774903635127;2144.0566150893555;2112.915483380663;2133.637281662121;2154.687570302313;2159.1862835218335;2170.2946542373793;7703.653335599855;7907.525548467111;7940.444168908179;7956.920430795733;7982.082060562993;4659.650526210514;4845.515448455161;4851.805927762921;4858.46556878743;4862.343583616202;2728.140635699748;2849.7292757188243;2888.870000849967;2909.418116376733;2909.723576260252;881.9779505512349;882.9028806831243;896.2068569316137;901.9323550733722;912.1243606138115;10801.297915635458;10917.508712107974;10919.672409827717;10931.890681093246;10933.945330273298;3975.4831871856472;4124.546299907008;4271.081717430768;4272.850450234289;4298.656107511454;8496.745097647081;8540.316774658013;8547.35894807892;8553.572321383906;8554.05905350411;4704.15325241453;4706.552877476634;4707.388039554836;4707.458642256116;4711.670183087151;3742.607026262258;3882.76703397797;3999.7200195986;4354.760488173118;4374.4531933508315;3214.7910385825317;3517.66582174693;3551.1832278575557;3586.8565257389414;3619.258052099366;1062.2245760594808;1084.1218612923558;1097.6103483263487;1108.6784832398675;1119.8040342939953;719.2376081353782;725.8584576007628;783.2128710645878;797.143071198464;820.5322965909494;5272.077386457355;5285.894282114336;5347.1979203119845;5518.944810551923;5870.178175055496;831.5468069901918;861.9956900215459;866.6100254885326;870.9259712924472;892.2727976698969;3354.8490317935753;3482.9651703483146;3495.1611613213154;3546.8226588670464;3633.1643721943574;9496.762580935394;9889.109980101824;9938.652147174958;9940.900590994142;9944.45305508204;9893.554790034466;9914.652987145415;9923.60305587783;9982.301238913205;9998.80002399948;7436.293552112541;7480.625968701544;7574.659140338808;7619.390448764086;7633.160352361236;5081.136206844772;5244.737763111905;5308.389535203501;5316.601254905975;5443.618946673695;8939.106089391009;9068.183863452321;9224.169824715807;9247.30645201626;9326.72019839406;8431.861698670846;9146.222571081533;9345.672901448417;9391.953040234755;9494.525273736148;5795.072788354012;6327.96836015817;6397.808065758035;6467.062275970052;6617.106690596708;7646.273604007611;7669.348105411103;7708.845823083395;7719.807004824925;7815.374770018271;6620.569662971891;6885.139357580302;6916.135483064617;6986;7174.282571742784;6588.604683718992;6687.398134167948;6742.25835158142;6749.595024298558;6911.481638877205;6174.907376389448;6203.193584833943;6266.655333956676;6271.78048768291;6275;4544.454665440168;4561.110583436198;4573.3140028994585;4618.63050955916;4652.209124448784;4650.279206722963;4652.790624421977;4676.929846052244;4684.625229981525;4790.371353579261 07:42:30 INFO - PROCESS | 13233 | |4;prototype.html;285.5046494332334;287.2101720269261;292.8887022931286;293.81196034537885;299.1295330587989;4580.839670611529;4717.481077081518;4751.691140075897;4843.878903027422;4844.975775121124;4536.115457485792;4671.416072990876;4685.50802165772;4713.740744259065;4718.504557021506;3738.12154143776;3759.6616304532654;3760.6427389397963;3762.9811850940705;3789.9810500947456;3517.7361697872634;3668.3396988542054;3745.288395204916;3766.8493260269556;3786.659200671939;3554.5734511858614;3700.85196592136;3700.907477313075;3704.944425833615;3717.721170912179;3688.317661232654;3695.854285171592;3697.6302369762807;3709.870154544578;3717.739758216926;3254.9584133077424;3262.6411094779555;3279.770416070876;3283.4746440569634;3283.4910588858766;4535.251683472223;4535.841245556389;4576.977115114437;4581.289900065495;4668.509806470306;4178.519470260898;4202.348635961431;4206.663466922639;4216.198922204771;4217.388478670576;4897.902041959141;4942.431620363668;4953.777080031371;4976.65630279826;4999.275105109738;3442.8278586070846;3572.5355703758346;3573.910652233689;3590.5691317042124;3606;5082.872928176788;5109.897802043938;5128.153854613947;5142.97428512855;5174.2238664200295;3631.055925459347;3636.3272794533095;3648.7445878788762;3652.0279049313604;3661.0481274868725;3701.796401197906;3702.962970370316;3707.94438083429;3710.6845918097265;3729.5710993235584;3946.2896678598127;4121.814518346681;4139.81370838313;4161.563035881189;4225.577442255812;4936.901261974812;4942.283368911488;4942.975285123552;4946.530079642428;4947.604191664658;1187.8812118788053;1217.4582310871576;1220.0239808153442;1246.2833870524485;1267.3093164225336;821.2813787935556;832.8667413213977;841.7895526118471;851.2594043182471;852.7313896122826;4354.172707185625;4362.607365337135;4386.18855511725;4390.780460976938;4400.779961001937;5042.5628695821515;5046.7476626168545;5053.5957123430035;5054.545090941833;5058.165402708585;4349.630281426051;4365.519792822787;4367.274926404052;4373.759443230653;4374.168907907488;2315.6191959738635;2352.941176470602;2356.9882150589137;2380.88095595223;2388.7730665587087;4185.497740271187;4218.894527636834;4227.513835908849;4238.915221695611;4277.348044212608;4564.3838081859185;4565.977170114128;4630.699004564693;4637.768111594474;4652;4207.8316867325575;4245.978770106191;4516.322551617218;4798.8560343189065;4825.806967721252;5115.718635475085;5121.334226550524;5125.820596279113;5130.486951304989;5140.228965655182;5013.2981382607195;5019.196928491424;5019.24326485727;5035.29505869186;5035.546800787946;4648.8842677757775;4784.47370789206;4825.782839772149;4844.491328410607;4863.635227357891;3614.9096272593397;3621.5473065866768;3626.4977165755545;3627.673509384168;3638.9454158188178;5098.898022039612;5112.341582377068;5119;5127.79488820443;5131.974340128425;4598;4723.858284251478;4805.543473370024;4833.661643684908;4949.282354058713;4924.138275801649;4977.875553111056;4984.22744474607;4989.25161225819;4991.57571606403;4870.025994800983;4873.343063358475;4874.147024270809;4881.658283920234;4887.413510378778;4794.640401969797;4915;5011.4487406386;5012.749362531932;5027.3464449621315;4833.734144621939;4883.194272944925;4887.141022501876;4901.877453063702;4969.304297398439 07:42:30 INFO - PROCESS | 13233 | |5;yui.html;640.4140211706289;672.9226138994011;673.6867356679144;701.1305980584077;706.9858602827943;12650.367481625917;13709.52016679414;13719.108257963251;13721.039527233084;13728.176309421442;12328;12435;12441.440135193916;12458.314792686399;12747.681307967283;615.6121643364673;626.1453116495973;734.2914087905157;738.9371903388219;753.9359154471877;758.4501236603473;759.0360242492031;759.3393747439735;759.760675387254;760.5588758520045;807.4105902691039;808.2483290539795;808.3492788305412;808.6239898447221;809.0372456776447;645.4707140145083;663.9402453779184;777.3081957058223;798.2297083314601;800.7877912353173;588.7998080652555;588.8233529941043;588.8292395205385;588.9469947704728;589.0957380421033;12143.392830358447;12185.817212741817;12188.08589355793;12199.695007624792;12218.144729868913;11097.056750176245;11167.553297868075;11810.055195584333;11902.821457678141;12095.395230238453;11856.762864742657;12015.339156346397;12201.572944946884;12220.327881966577;12310.569130080494;3875.147467557133;3909.2181563687377;3910.061585219555;4100.938485922714;4102.897427564305;62967;64534.354656453776;64885;64908.67545662241;66289.66855165742;9176.770580735401;9260.861087083698;9272.211342472356;9385.765355866022;9419.34064615484;18100;18180;18243.54391140232;18435.170417331254;18451.630967380577;6000.189974353407;6202.596831205957;6459.870802583922;6489.545731798728;6827.761028363983;3505.5618047744033;3541.734369922266;3569.5716514017963;3622.8188590570894;3644.0322225998193;2761.875715592763;2862.742353188223;2884.4663737208684;2887.6101726266684;2893.5225687761285;467.66561908235775;471.4554689333825;483.8596806925952;486.4624589828189;490.76933841094626;451.75379418217153;498.39942868843684;502.73103889418985;503.8513638476585;526.5287567627029;7049.3655570997835;7152.499325047197;7665.578393188428;7684.807879803049;7814;476.80212711724243;479.95440433158797;532.7229840483004;535.6357676779827;547.690554836524;3317.5023746437746;3319.2199833039217;3340.916477088092;3374.6287908330064;3541.11472131967;88800;95630;101412.49293753484;101596;103380.48309758403;49757.25364119541;60391.69804150951;85803.14196858076;86796.5660171695;90462.54768726115;58300;71792;77673.61163194147;78167.60916195382;78941;6883.6342734822665;6917.792466226021;7114.430845532448;7151.2848715128075;7460.738874139379;39161.60838391694;39550.208995820496;40035.59964400319;41518;45747;47735.28397074116;58571.4142858566;59531;60841;61123;9866.605335786775;9998.750031249278;10046.748831279276;11046.668599942015;11179;12408.441620126936;12597.622071337875;12686.365681716063;13468.655881486186;13479.663008424868;10735.248532602644;10871.836922446011;11228.326300422;11340.432978351215;11361;11439.370834603844;11581.594644187413;12407.875921240671;12492.312922789333;12494.187877787916;11353.318800871974;11414.258073225214;12214.083943704436;12304.138710290194;12305.630831075083;9727.85408218863;9983.500824958868;10023.398596084258;10116.544755485873;10120.392776433437;9468.95265523668;9895.505224738878;9944.950275248577;10053.648122315684;10241.897581024094 07:42:30 INFO - PROCESS | 13233 | __end_tp_report 07:42:30 INFO - PROCESS | 13233 | __start_cc_report 07:42:30 INFO - PROCESS | 13233 | _x_x_mozilla_cycle_collect,848 07:42:30 INFO - PROCESS | 13233 | __end_cc_report 07:42:30 INFO - PROCESS | 13233 | __startTimestamp1474900950819__endTimestamp 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | ------- Summary: start ------- 07:42:30 INFO - PROCESS | 13233 | Number of tests: 6 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#0] dojo.html Cycles:165 Average:4631.25 Median:4771.86 stddev:473.31 (9.9%) stddev-sans-first:446.33 07:42:30 INFO - PROCESS | 13233 | Values: 2571.6 2607.9 2636.1 2646.0 2662.2 4645.3 4728.6 4760.9 4765.6 4779.9 4665.4 4731.1 4753.3 4764.4 4816.5 4282.5 4321.4 4335.2 4370.2 4376.0 4355.0 4412.2 4436.7 4452.0 4504.3 4404.6 4432.7 4453.1 4458.5 4493.9 4260.8 4271.4 4304.1 4329.8 4330.8 4233.2 4236.8 4241.2 4349.5 4392.6 4693.8 4703.9 4712.3 4722.0 4780.4 4894.9 4896.9 4951.9 5036.9 5059.4 4955.7 4965.8 4967.4 4970.1 5021.3 4634.5 4645.3 4645.8 4647.7 4666.3 5007.5 5012.3 5060.3 5212.2 5250.3 4882.0 4903.5 4904.6 4946.6 4967.8 4975.1 4977.9 4980.1 4985.5 5052.8 4834.3 4897.8 4945.0 4952.5 5008.5 4942.0 4953.3 4965.6 4990.7 4999.7 4190.8 4193.6 4197.2 4243.9 4254.5 3694.8 3716.6 3719.3 3757.1 3791.7 4250.2 4308.4 4309.4 4339.8 4378.3 5009.1 5014.4 5016.2 5041.6 5083.6 4283.2 4321.0 4322.2 4337.4 4369.2 4439.2 4470.7 4481.9 4509.6 4517.7 4687.7 4721.6 4723.7 4760.7 4774.7 5018.1 5021.4 5031.3 5031.4 5086.8 4594.7 4614.7 4713.5 4720.9 4781.3 4847.0 4897.6 4903.6 4905.4 4967.3 4981.0 4984.3 4990.7 4991.7 5057.5 4770.2 4857.4 4859.8 4878.5 4911.4 4808.2 4822.8 4828.5 4863.3 4933.6 4771.9 4783.2 4787.0 4810.9 4832.2 4844.3 4892.9 4903.3 4912.6 4927.8 4769.6 4785.2 4794.5 4834.0 4848.4 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#1] ext.html Cycles:180 Average:49436.93 Median:35686.55 stddev:99270.39 (278.2%) stddev-sans-first:99480.97 07:42:30 INFO - PROCESS | 13233 | Values: 531.8 565.8 568.7 576.8 581.7 27057.0 30024.5 41612.8 42841.8 42875.1 38366.6 38832.4 38842.6 38851.6 38852.4 7237.9 7630.7 7812.5 7816.9 7824.9 7199.4 7469.6 7488.2 7490.4 9713.2 9762.0 10136.1 10159.2 10173.9 10177.9 9966.4 10035.5 10055.7 10056.0 10056.4 9855.2 9918.9 9920.9 9926.6 9928.0 37253.6 37567.2 37581.8 37591.6 37645.8 3007.5 3048.4 3072.2 3105.9 3276.6 27590.4 28006.6 28134.7 28552.9 29621.4 2960.3 3066.5 3109.3 3163.7 3192.3 247057.0 248324.0 249661.0 250364.0 250494.0 30530.0 31132.1 31194.4 49047.0 49344.3 32264.8 32534.2 32668.7 32700.5 32739.2 12663.2 12874.4 12875.4 12879.2 12882.4 9811.5 9913.8 9925.0 9925.6 9932.2 7093.8 7202.3 7413.0 7605.0 7664.2 3020.6 3039.5 3040.6 3046.4 3071.0 847.4 918.2 953.6 1002.7 1017.7 26940.2 27531.7 27664.7 27847.4 28062.0 880.6 906.2 933.1 972.0 1013.3 14278.2 14672.9 14733.3 14870.5 14923.3 381840.0 385644.0 385742.0 386377.0 387266.0 41852.0 42663.6 45345.0 46655.8 47503.3 1150.7 1153.1 1161.4 1171.0 1179.2 26755.0 28140.3 28854.4 29197.6 29265.9 40928.0 40989.4 41276.6 41458.2 41477.4 359319.0 371996.0 373340.0 561877.0 561902.0 36791.0 37361.3 37476.6 37657.8 37905.0 41169.0 41338.6 41437.0 41723.6 42060.4 34977.5 34995.7 35629.8 35743.3 36007.5 35390.0 35496.8 35828.0 35842.8 35871.0 34029.8 34557.5 34562.5 34659.3 35362.0 29965.4 32072.2 32280.8 32398.4 32529.8 24793.3 24910.3 25207.1 25343.7 25545.7 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#2] jquery.html Cycles:180 Average:22677.71 Median:4294.59 stddev:56995.32 (1327.1%) stddev-sans-first:57130.57 07:42:30 INFO - PROCESS | 13233 | Values: 356.0 367.6 374.7 377.0 394.6 12401.3 15283.8 16007.1 16412.0 17397.3 15577.4 16596.6 16910.4 17069.7 17239.0 4892.3 5090.2 5242.7 5473.8 5528.9 3459.5 3617.9 5493.3 5526.7 5531.8 3581.2 3582.9 3620.9 3647.7 3751.2 5999.8 6092.8 6094.4 6097.8 6098.1 5230.6 5288.3 5331.3 5331.9 5387.6 12467.2 12679.6 12693.7 12765.8 20696.1 1827.7 1854.2 1971.5 1999.8 2313.8 9225.7 9512.8 9574.3 9794.8 10632.0 1649.0 1679.8 1720.5 1798.9 1804.2 60754.4 64251.4 67907.7 70069.6 73170.0 9422.2 9668.2 9926.0 9959.2 10027.1 13763.9 13771.2 13771.4 13773.3 13773.4 6832.1 6848.1 6903.5 7116.0 7183.3 6317.7 6767.0 6795.3 6999.4 7028.7 4245.8 4343.4 4346.3 4381.5 4411.3 1773.5 1790.2 1813.5 1829.2 1901.5 735.4 789.6 838.3 914.9 925.6 15585.9 16420.8 16814.7 16939.3 17165.0 908.8 909.1 910.1 923.3 931.5 8947.4 9410.7 9454.3 9496.2 9546.8 339329.0 340138.0 342183.0 342266.0 351374.0 73639.6 75106.2 75685.2 77350.0 78752.0 864.6 870.2 888.4 894.2 894.5 13852.4 14126.8 14208.0 14330.4 14906.1 37171.6 39431.6 39958.4 40050.2 40810.2 47516.3 48672.0 51903.5 53168.7 53180.7 7571.9 7635.7 7662.7 7718.2 7719.5 8949.6 11526.7 11644.4 11790.7 12070.9 10036.7 10121.8 10454.2 10652.6 10723.4 10205.9 10324.7 10326.8 10464.3 10529.8 9792.7 10112.3 10159.6 10278.6 10742.7 7768.8 7912.2 7979.8 7986.6 8195.1 9874.5 9892.6 10190.5 10365.3 10460.1 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#3] mootools.html Cycles:180 Average:5168.74 Median:5331.90 stddev:2940.05 (55.1%) stddev-sans-first:2933.55 07:42:30 INFO - PROCESS | 13233 | Values: 1249.6 1346.0 1378.4 1405.8 1672.5 7027.0 7581.5 7826.5 7828.0 8076.2 7935.1 8010.4 8014.9 8016.2 8018.2 2175.6 2201.1 2204.2 2204.7 2205.0 2127.0 2147.8 2200.4 2204.5 2208.3 2121.9 2126.9 2132.7 2136.5 2171.0 2127.4 2136.3 2139.3 2143.8 2144.1 2112.9 2133.6 2154.7 2159.2 2170.3 7703.7 7907.5 7940.4 7956.9 7982.1 4659.7 4845.5 4851.8 4858.5 4862.3 2728.1 2849.7 2888.9 2909.4 2909.7 882.0 882.9 896.2 901.9 912.1 10801.3 10917.5 10919.7 10931.9 10933.9 3975.5 4124.5 4271.1 4272.9 4298.7 8496.7 8540.3 8547.4 8553.6 8554.1 4704.2 4706.6 4707.4 4707.5 4711.7 3742.6 3882.8 3999.7 4354.8 4374.5 3214.8 3517.7 3551.2 3586.9 3619.3 1062.2 1084.1 1097.6 1108.7 1119.8 719.2 725.9 783.2 797.1 820.5 5272.1 5285.9 5347.2 5518.9 5870.2 831.5 862.0 866.6 870.9 892.3 3354.8 3483.0 3495.2 3546.8 3633.2 9496.8 9889.1 9938.7 9940.9 9944.5 9893.6 9914.7 9923.6 9982.3 9998.8 7436.3 7480.6 7574.7 7619.4 7633.2 5081.1 5244.7 5308.4 5316.6 5443.6 8939.1 9068.2 9224.2 9247.3 9326.7 8431.9 9146.2 9345.7 9392.0 9494.5 5795.1 6328.0 6397.8 6467.1 6617.1 7646.3 7669.3 7708.8 7719.8 7815.4 6620.6 6885.1 6916.1 6986.0 7174.3 6588.6 6687.4 6742.3 6749.6 6911.5 6174.9 6203.2 6266.7 6271.8 6275.0 4544.5 4561.1 4573.3 4618.6 4652.2 4650.3 4652.8 4676.9 4684.6 4790.4 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#4] prototype.html Cycles:180 Average:4066.83 Median:4550.25 stddev:1185.29 (26.0%) stddev-sans-first:1154.13 07:42:30 INFO - PROCESS | 13233 | Values: 285.5 287.2 292.9 293.8 299.1 4580.8 4717.5 4751.7 4843.9 4845.0 4536.1 4671.4 4685.5 4713.7 4718.5 3738.1 3759.7 3760.6 3763.0 3790.0 3517.7 3668.3 3745.3 3766.8 3786.7 3554.6 3700.9 3700.9 3704.9 3717.7 3688.3 3695.9 3697.6 3709.9 3717.7 3255.0 3262.6 3279.8 3283.5 3283.5 4535.3 4535.8 4577.0 4581.3 4668.5 4178.5 4202.3 4206.7 4216.2 4217.4 4897.9 4942.4 4953.8 4976.7 4999.3 3442.8 3572.5 3573.9 3590.6 3606.0 5082.9 5109.9 5128.2 5143.0 5174.2 3631.1 3636.3 3648.7 3652.0 3661.0 3701.8 3703.0 3707.9 3710.7 3729.6 3946.3 4121.8 4139.8 4161.6 4225.6 4936.9 4942.3 4943.0 4946.5 4947.6 1187.9 1217.5 1220.0 1246.3 1267.3 821.3 832.9 841.8 851.3 852.7 4354.2 4362.6 4386.2 4390.8 4400.8 5042.6 5046.7 5053.6 5054.5 5058.2 4349.6 4365.5 4367.3 4373.8 4374.2 2315.6 2352.9 2357.0 2380.9 2388.8 4185.5 4218.9 4227.5 4238.9 4277.3 4564.4 4566.0 4630.7 4637.8 4652.0 4207.8 4246.0 4516.3 4798.9 4825.8 5115.7 5121.3 5125.8 5130.5 5140.2 5013.3 5019.2 5019.2 5035.3 5035.5 4648.9 4784.5 4825.8 4844.5 4863.6 3614.9 3621.5 3626.5 3627.7 3638.9 5098.9 5112.3 5119.0 5127.8 5132.0 4598.0 4723.9 4805.5 4833.7 4949.3 4924.1 4977.9 4984.2 4989.3 4991.6 4870.0 4873.3 4874.1 4881.7 4887.4 4794.6 4915.0 5011.4 5012.7 5027.3 4833.7 4883.2 4887.1 4901.9 4969.3 07:42:30 INFO - PROCESS | 13233 | 07:42:30 INFO - PROCESS | 13233 | [#5] yui.html Cycles:180 Average:17157.26 Median:24107.62 stddev:24676.97 (102.4%) stddev-sans-first:24715.03 07:42:30 INFO - PROCESS | 13233 | Values: 640.4 672.9 673.7 701.1 707.0 12650.4 13709.5 13719.1 13721.0 13728.2 12328.0 12435.0 12441.4 12458.3 12747.7 615.6 626.1 734.3 738.9 753.9 758.5 759.0 759.3 759.8 760.6 807.4 808.2 808.3 808.6 809.0 645.5 663.9 777.3 798.2 800.8 588.8 588.8 588.8 588.9 589.1 12143.4 12185.8 12188.1 12199.7 12218.1 11097.1 11167.6 11810.1 11902.8 12095.4 11856.8 12015.3 12201.6 12220.3 12310.6 3875.1 3909.2 3910.1 4100.9 4102.9 62967.0 64534.4 64885.0 64908.7 66289.7 9176.8 9260.9 9272.2 9385.8 9419.3 18100.0 18180.0 18243.5 18435.2 18451.6 6000.2 6202.6 6459.9 6489.5 6827.8 3505.6 3541.7 3569.6 3622.8 3644.0 2761.9 2862.7 2884.5 2887.6 2893.5 467.7 471.5 483.9 486.5 490.8 451.8 498.4 502.7 503.9 526.5 7049.4 7152.5 7665.6 7684.8 7814.0 476.8 480.0 532.7 535.6 547.7 3317.5 3319.2 3340.9 3374.6 3541.1 88800.0 95630.0 101412.5 101596.0 103380.5 49757.3 60391.7 85803.1 86796.6 90462.5 58300.0 71792.0 77673.6 78167.6 78941.0 6883.6 6917.8 7114.4 7151.3 7460.7 39161.6 39550.2 40035.6 41518.0 45747.0 47735.3 58571.4 59531.0 60841.0 61123.0 9866.6 9998.8 10046.7 11046.7 11179.0 12408.4 12597.6 12686.4 13468.7 13479.7 10735.2 10871.8 11228.3 11340.4 11361.0 11439.4 11581.6 12407.9 12492.3 12494.2 11353.3 11414.3 12214.1 12304.1 12305.6 9727.9 9983.5 10023.4 10116.5 10120.4 9469.0 9895.5 9945.0 10053.6 10241.9 07:42:30 INFO - PROCESS | 13233 | -------- Summary: end -------- 07:42:30 INFO - PROCESS | 13233 | 07:42:31 INFO - TEST-INFO | 13233: exit 0 07:42:31 INFO - TEST-OK | dromaeo_css | took 1122401ms 07:42:31 INFO - TEST-START | kraken 07:42:31 INFO - operating with platform_type : linux_ 07:42:31 INFO - Initialising browser for kraken test... 07:42:31 INFO - TEST-INFO | started process 13579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hclYO/profile http://localhost:38873/getInfo.html) 07:42:36 INFO - PROCESS | 13579 | __metrics Screen width/height:1600/1200 07:42:36 INFO - PROCESS | 13579 | colorDepth:24 07:42:36 INFO - PROCESS | 13579 | Browser inner width/height: 1024/697 07:42:36 INFO - PROCESS | 13579 | __metrics 07:42:37 INFO - PROCESS | 13579 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:42:37 INFO - PROCESS | 13579 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:38 INFO - PROCESS | 13579 | console.error: PushService: 07:42:38 INFO - PROCESS | 13579 | stateChangeProcessEnqueue: Error transitioning state 07:42:38 INFO - PROCESS | 13579 | UnknownError 07:42:38 INFO - TEST-INFO | 13579: exit 0 07:42:38 INFO - Browser initialized. 07:42:38 INFO - Running cycle 1/1 for kraken test... 07:42:38 INFO - TEST-INFO | started process 13661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hclYO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:51 INFO - PROCESS | 13661 | RSS: Main: 175579136 07:42:51 INFO - PROCESS | 13661 | 07:42:53 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38873/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:54 INFO - PROCESS | 13661 | RSS: Main: 234487808 07:42:54 INFO - PROCESS | 13661 | 07:42:57 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38873/tests/kraken/driver.html?testName=audio-dft) 07:42:58 INFO - PROCESS | 13661 | RSS: Main: 218710016 07:42:58 INFO - PROCESS | 13661 | 07:43:01 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38873/tests/kraken/driver.html?testName=audio-fft) 07:43:02 INFO - PROCESS | 13661 | RSS: Main: 300277760 07:43:02 INFO - PROCESS | 13661 | 07:43:04 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38873/tests/kraken/driver.html?testName=audio-oscillator) 07:43:04 INFO - PROCESS | 13661 | RSS: Main: 209805312 07:43:04 INFO - PROCESS | 13661 | 07:43:07 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:07 INFO - PROCESS | 13661 | RSS: Main: 214417408 07:43:07 INFO - PROCESS | 13661 | 07:43:10 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38873/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:11 INFO - PROCESS | 13661 | RSS: Main: 250011648 07:43:11 INFO - PROCESS | 13661 | 07:43:14 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38873/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:15 INFO - PROCESS | 13661 | RSS: Main: 250392576 07:43:15 INFO - PROCESS | 13661 | 07:43:18 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38873/tests/kraken/driver.html?testName=json-parse-financial) 07:43:19 INFO - PROCESS | 13661 | RSS: Main: 249249792 07:43:19 INFO - PROCESS | 13661 | 07:43:20 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:43:21 INFO - PROCESS | 13661 | RSS: Main: 211226624 07:43:21 INFO - PROCESS | 13661 | 07:43:23 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:43:23 INFO - PROCESS | 13661 | RSS: Main: 217972736 07:43:23 INFO - PROCESS | 13661 | 07:43:26 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:43:26 INFO - PROCESS | 13661 | RSS: Main: 223137792 07:43:26 INFO - PROCESS | 13661 | 07:43:29 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:43:30 INFO - PROCESS | 13661 | RSS: Main: 218972160 07:43:30 INFO - PROCESS | 13661 | 07:43:33 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:43:33 INFO - PROCESS | 13661 | RSS: Main: 222453760 07:43:33 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | Cycle 1(1): loaded http://localhost:38873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38873/tests/kraken/driver.html?testName=ai-astar) 07:43:35 INFO - PROCESS | 13661 | RSS: Main: 273334272 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | __start_tp_report 07:43:35 INFO - PROCESS | 13661 | _x_x_mozilla_page_load 07:43:35 INFO - PROCESS | 13661 | _x_x_mozilla_page_load_details 07:43:35 INFO - PROCESS | 13661 | |i|pagename|runs| 07:43:35 INFO - PROCESS | 13661 | |0;ai-astar;113;116;116;116;116;115;115;115;114;115 07:43:35 INFO - PROCESS | 13661 | |1;audio-beat-detection;152;125;126;164;130;124;129;129;162;129 07:43:35 INFO - PROCESS | 13661 | |2;audio-dft;161;161;162;161;162;163;164;162;162;162 07:43:35 INFO - PROCESS | 13661 | |3;audio-fft;76;77;77;116;78;78;77;76;108;77 07:43:35 INFO - PROCESS | 13661 | |4;audio-oscillator;84;83;112;84;83;83;118;84;84;120 07:43:35 INFO - PROCESS | 13661 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 07:43:35 INFO - PROCESS | 13661 | |6;imaging-darkroom;147;146;146;146;146;146;147;146;147;146 07:43:35 INFO - PROCESS | 13661 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;94 07:43:35 INFO - PROCESS | 13661 | |8;json-parse-financial;64;62;61;62;64;63;64;63;64;62 07:43:35 INFO - PROCESS | 13661 | |9;json-stringify-tinderbox;65;66;66;66;67;66;66;67;66;66 07:43:35 INFO - PROCESS | 13661 | |10;stanford-crypto-aes;89;88;89;95;83;82;83;81;82;82 07:43:35 INFO - PROCESS | 13661 | |11;stanford-crypto-ccm;136;145;134;133;134;134;141;132;183;144 07:43:35 INFO - PROCESS | 13661 | |12;stanford-crypto-pbkdf2;182;176;174;176;173;178;179;177;174;180 07:43:35 INFO - PROCESS | 13661 | |13;stanford-crypto-sha256-iterative;72;70;75;71;76;73;70;70;69;69 07:43:35 INFO - PROCESS | 13661 | __end_tp_report 07:43:35 INFO - PROCESS | 13661 | __start_cc_report 07:43:35 INFO - PROCESS | 13661 | _x_x_mozilla_cycle_collect,1955 07:43:35 INFO - PROCESS | 13661 | __end_cc_report 07:43:35 INFO - PROCESS | 13661 | __startTimestamp1474901015949__endTimestamp 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | ------- Summary: start ------- 07:43:35 INFO - PROCESS | 13661 | Number of tests: 14 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:0.99 (0.9%) stddev-sans-first:0.71 07:43:35 INFO - PROCESS | 13661 | Values: 113.0 116.0 116.0 116.0 116.0 115.0 115.0 115.0 114.0 115.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:129.50 stddev:15.83 (12.2%) stddev-sans-first:15.83 07:43:35 INFO - PROCESS | 13661 | Values: 152.0 125.0 126.0 164.0 130.0 124.0 129.0 129.0 162.0 129.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 07:43:35 INFO - PROCESS | 13661 | Values: 161.0 161.0 162.0 161.0 162.0 163.0 164.0 162.0 162.0 162.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#3] audio-fft Cycles:10 Average:84.00 Median:77.00 stddev:14.89 (19.3%) stddev-sans-first:15.51 07:43:35 INFO - PROCESS | 13661 | Values: 76.0 77.0 77.0 116.0 78.0 78.0 77.0 76.0 108.0 77.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.50 stddev:16.11 (19.3%) stddev-sans-first:16.72 07:43:35 INFO - PROCESS | 13661 | Values: 84.0 83.0 112.0 84.0 83.0 83.0 118.0 84.0 84.0 120.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:43:35 INFO - PROCESS | 13661 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:43:35 INFO - PROCESS | 13661 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:43:35 INFO - PROCESS | 13661 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.50 stddev:1.10 (1.7%) stddev-sans-first:1.09 07:43:35 INFO - PROCESS | 13661 | Values: 64.0 62.0 61.0 62.0 64.0 63.0 64.0 63.0 64.0 62.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 07:43:35 INFO - PROCESS | 13661 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 66.0 66.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:4.60 (5.4%) stddev-sans-first:4.69 07:43:35 INFO - PROCESS | 13661 | Values: 89.0 88.0 89.0 95.0 83.0 82.0 83.0 81.0 82.0 82.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:138.50 stddev:15.28 (11.0%) stddev-sans-first:16.08 07:43:35 INFO - PROCESS | 13661 | Values: 136.0 145.0 134.0 133.0 134.0 134.0 141.0 132.0 183.0 144.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.50 stddev:2.88 (1.6%) stddev-sans-first:2.40 07:43:35 INFO - PROCESS | 13661 | Values: 182.0 176.0 174.0 176.0 173.0 178.0 179.0 177.0 174.0 180.0 07:43:35 INFO - PROCESS | 13661 | 07:43:35 INFO - PROCESS | 13661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:2.46 (3.4%) stddev-sans-first:2.60 07:43:35 INFO - PROCESS | 13661 | Values: 72.0 70.0 75.0 71.0 76.0 73.0 70.0 70.0 69.0 69.0 07:43:35 INFO - PROCESS | 13661 | -------- Summary: end -------- 07:43:35 INFO - PROCESS | 13661 | 07:43:37 INFO - TEST-INFO | 13661: exit 0 07:43:37 INFO - TEST-OK | kraken | took 65433ms 07:43:37 INFO - SUITE-END | took 1187s 07:43:37 INFO - Completed test suite (00:19:48) 07:43:37 INFO - javascript benchmark 07:43:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.62711406846, 2607.93480162996, 2636.0510216322127, 2645.973540264597, 2662.1614191529666, 4645.256758918574, 4728.621710263179, 4760.928586071207, 4765.594924431419, 4779.904401911964, 4665.370175026371, 4731.101090792756, 4753.287006948951, 4764.428268607763, 4816.458733205367, 4282.528921818597, 4321.373400856874, 4335.197988372145, 4370.1915145697985, 4375.978120109411, 4355.0201204729, 4412.205802955466, 4436.689431739779, 4451.955480445203, 4504.301833215857, 4404.603585677304, 4432.689711720181, 4453.109378124372, 4458.464984201884, 4493.932591011121, 4260.7656578888145, 4271.380649805792, 4304.096139810644, 4329.848455304081, 4330.805113769857, 4233.23801715691, 4236.788160591958, 4241.172971270604, 4349.543297953701, 4392.560743925614, 4693.812247510095, 4703.905921881543, 4712.340272361872, 4721.976390118028, 4780.402449693788, 4894.877628059291, 4896.926546101811, 4951.925721114186, 5036.899262014776, 5059.418166910778, 4955.653104282702, 4965.826196083156, 4967.403911530603, 4970.13022721026, 5021.322121513622, 4634.513565524342, 4645.256758918556, 4645.814167433265, 4647.651426143053, 4666.253399456071, 5007.474215207423, 5012.298278241049, 5060.2662613920775, 5212.244224587414, 5250.264962905197, 4882.023595280958, 4903.509649035068, 4904.558589726942, 4946.604271658259, 4967.776450059756, 4975.054739599537, 4977.925331120036, 4980.12847751642, 4985.476524964826, 5052.797888084509, 4834.347363106006, 4897.7795999180125, 4944.975275123601, 4952.529509696573, 5008.474110218374, 4942.0, 4953.2570114483115, 4965.602751779849, 4990.675606085593, 4999.725015124203, 4190.790460476964, 4193.643540299109, 4197.202531519001, 4243.851465198703, 4254.489461264668, 3694.833732482045, 3716.591174970751, 3719.3119272934596, 3757.1358587524473, 3791.7156213284115, 4250.213710463574, 4308.353746937984, 4309.439772829513, 4339.82640694375, 4378.277584198571, 5009.12340340439, 5014.423341315723, 5016.197408414636, 5041.621878359065, 5083.6187285952965, 4283.207606592728, 4321.006168581244, 4322.178786030644, 4337.436133302651, 4369.213541562549, 4439.200943830077, 4470.731756094645, 4481.887952801206, 4509.571590698878, 4517.728936263835, 4687.69529980557, 4721.622270218443, 4723.716577005391, 4760.690555113906, 4774.665773395829, 5018.1469150245275, 5021.4225364083595, 5031.345925029869, 5031.396232452129, 5086.821961231339, 4594.678372513892, 4614.700044497097, 4713.528647135397, 4720.858374248778, 4781.282807578891, 4846.975765121152, 4897.632677549269, 4903.6077113831525, 4905.386826646669, 4967.329410529533, 4980.978899325557, 4984.302197692254, 4990.72551009698, 4991.725455100004, 5057.494250574913, 4770.212914869007, 4857.441394239567, 4859.829905953275, 4878.536539028786, 4911.386076740408, 4808.182608956416, 4822.7829747660735, 4828.493008234085, 4863.3434486343895, 4933.55597996182, 4771.856844294677, 4783.234682450791, 4786.976065119791, 4810.8797280068275, 4832.226843704991, 4844.32179494864, 4892.902141957212, 4903.26451032348, 4912.606991440604, 4927.827526036572, 4769.61843052548, 4785.234362501983, 4794.472608013186, 4833.951660483491, 4848.393950756155], "value": 4601.531114001981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.8431062836465, 565.790657456741, 568.7184843502467, 576.8010036537393, 581.6742624130486, 27057.0, 30024.54963175554, 41612.791936040274, 42841.785791071, 42875.14249715004, 38366.61633383665, 38832.417513737244, 38842.61157388432, 38851.61148388515, 38852.41721374181, 7237.9276207238045, 7630.694772209105, 7812.453128281023, 7816.921830781705, 7824.921750782505, 7199.424046076328, 7469.626518674072, 7488.213737557559, 7490.363319117854, 9713.222942164644, 9762.0, 10136.138428233573, 10159.187265018782, 10173.94913025434, 10177.898221017806, 9966.352187107852, 10035.498225088717, 10055.69832905014, 10056.0, 10056.396616202977, 9855.211583073336, 9918.90081099187, 9920.851187232198, 9926.553305101288, 9928.0, 37253.627463725556, 37567.24865502702, 37581.812090939646, 37591.62408375909, 37645.81177094125, 3007.533832255982, 3048.3903219356, 3072.1858707442548, 3105.922351941197, 3276.5576647152566, 27590.448191036267, 28006.5799013015, 28134.71865281362, 28552.857235713895, 29621.407571848657, 2960.319126600872, 3066.47869862124, 3109.253779093024, 3163.715265626082, 3192.2657788708725, 247057.0, 248324.0, 249661.0, 250364.0, 250494.0, 30530.0, 31132.066038018897, 31194.376112477625, 49047.0, 49344.25983610249, 32264.83867580647, 32534.186645334055, 32668.67331326656, 32700.509492357633, 32739.181520462178, 12663.240205587694, 12874.420651070724, 12875.420606072748, 12879.16285441462, 12882.355882205853, 9811.460369679593, 9913.752156196153, 9924.950375248078, 9925.60297588103, 9932.205423566098, 7093.751718689821, 7202.279772022861, 7413.0, 7605.011348524767, 7664.233576642291, 3020.592220050265, 3039.452898478295, 3040.619922509686, 3046.3754930239247, 3070.9846450767604, 847.3856454070749, 918.2011649864527, 953.6328513522344, 1002.6941782756184, 1017.6946915925341, 26940.191794246202, 27531.724682753316, 27664.723352766618, 27847.443051138864, 28062.0, 880.5905254056894, 906.211595911548, 933.0576118120747, 971.9562619682131, 1013.3312014070679, 14278.214698191492, 14672.949029914542, 14733.336999835034, 14870.479533216285, 14923.328450219766, 381840.0, 385644.0, 385742.0, 386377.0, 387266.0, 41852.0, 42663.57336426658, 45345.0, 46655.766721166176, 47503.287450688265, 1150.654803558929, 1153.0890596428894, 1161.384466232898, 1170.9941450292695, 1179.2393905930799, 26755.0, 28140.296492587848, 28854.42291154207, 29197.562036569892, 29265.85367073151, 40928.0, 40989.38515922204, 41276.58723412848, 41458.170836583704, 41477.377839333036, 359319.0, 371996.0, 373340.0, 561877.0, 561902.0, 36791.0, 37361.25277494489, 37476.625233748404, 37657.81171094127, 37905.0, 41168.954329922635, 41338.58661413468, 41437.0, 41723.58276417318, 42060.36909446299, 34977.475337869444, 34995.65004349924, 35629.82185089058, 35743.285134296646, 36007.45988810118, 35390.0, 35496.82251588725, 35828.0, 35842.82078589591, 35871.0, 34029.82985085059, 34557.481637775956, 34562.48156277708, 34659.30681386409, 35362.0, 29965.400691985604, 32072.198195045312, 32280.83859580781, 32398.352032958737, 32529.837350813094, 24793.256202313958, 24910.252692419257, 25207.11775087863, 25343.74656253414, 25545.744542554337], "value": 16645.63461999214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.98754043608477, 367.6323676323676, 374.68152070739865, 376.96607305342513, 394.5758309816946, 12401.255924644516, 15283.847161528382, 16007.119608421532, 16412.0, 17397.304107835673, 15577.376904923789, 16596.585085372873, 16910.408135715254, 17069.658606827856, 17239.0, 4892.26616007599, 5090.24386586627, 5242.659227150242, 5473.808416705416, 5528.944710552903, 3459.4983727359518, 3617.94573081404, 5493.313335833021, 5526.668399896019, 5531.834044978637, 3581.212133330663, 3582.897582268314, 3620.9094772630633, 3647.689946354563, 3751.1934933989187, 5999.760009599632, 6092.756289748405, 6094.390560943914, 6097.786577469789, 6098.14625952367, 5230.607704422146, 5288.338957630296, 5331.333583302087, 5331.893362132736, 5387.568994480472, 12467.189632673848, 12679.619611411672, 12693.682657933625, 12765.808512872314, 20696.068676909574, 1827.7075667893207, 1854.156358856717, 1971.546544294806, 1999.8100180482832, 2313.849599776026, 9225.677101301422, 9512.762180945463, 9574.281928855295, 9794.755131121708, 10631.989960953697, 1648.9752653710204, 1679.8404151605578, 1720.5096547484031, 1798.8830726002768, 1804.2061492943062, 60754.39245607576, 64251.357486425004, 67907.66046169787, 70069.64965175193, 73170.0, 9422.246220302359, 9668.178204852526, 9925.950370248247, 9959.153471954965, 10027.147692446079, 13763.862361376257, 13771.173729576058, 13771.380287887068, 13773.311334433238, 13773.38019789112, 6832.111825462658, 6848.075509806113, 6903.482238832108, 7115.964420177866, 7183.281671832775, 6317.652529110943, 6766.966165169143, 6795.3204679531655, 6999.405050570758, 7028.683709233097, 4245.766482843412, 4343.4136391586735, 4346.326319420495, 4381.474223093185, 4411.2941929291155, 1773.4945540521148, 1790.185465613143, 1813.5012871460453, 1829.2408650409932, 1901.4580844459263, 735.433716038658, 789.6407134753788, 838.279079991207, 914.9130832570895, 925.629748100765, 15585.922070389803, 16420.83579164217, 16814.66370672604, 16939.322427103023, 17165.0, 908.8409528332515, 909.0500427053745, 910.1171863292595, 923.2936803345447, 931.464407965409, 8947.418417802823, 9410.71767846952, 9454.290928180413, 9496.192823609932, 9546.761330966643, 339329.0, 340138.0, 342183.0, 342266.0, 351374.0, 73639.63180184065, 75106.24893751102, 75685.24314756892, 77350.0, 78752.0, 864.5849992003873, 870.2428886868338, 888.395890794266, 894.1952242981368, 894.4543828264754, 13852.376643050886, 14126.78809817833, 14208.0, 14330.355134018786, 14906.105633662015, 37171.628283717895, 39431.60568394394, 39958.400623990085, 40050.1989960205, 40810.18379632331, 47516.2872556905, 48672.0, 51903.48096518986, 53168.734156328974, 53180.73409632927, 7571.924280757342, 7635.732749353746, 7662.693492260247, 7718.189590092959, 7719.459637825298, 8949.59726812308, 11526.711832204262, 11644.417779110841, 11790.705232369259, 12070.879291207328, 10036.698899032748, 10121.848172277274, 10454.215933804842, 10652.57389704403, 10723.356598604109, 10205.948970255102, 10324.741881453023, 10326.793464130526, 10464.267501275142, 10529.789404212026, 9792.657256995972, 10112.342697724624, 10159.644412445528, 10278.640247591298, 10742.677719668422, 7768.7669369918995, 7912.248336408032, 7979.760607181794, 7986.640601172845, 8195.139510351328, 9874.456904870302, 9892.604295828087, 10190.490475476048, 10365.274430789772, 10460.058594726512], "value": 7966.928290507029, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.6376050945225, 1345.9528916487925, 1378.3728403576374, 1405.761020626494, 1672.5426737743912, 7026.964865175673, 7581.469297149201, 7826.530408175499, 7827.960860195705, 8076.232757888006, 7935.087464941534, 8010.439269251155, 8014.879776803353, 8016.238457346542, 8018.238267364591, 2175.5866385386803, 2201.0535469748, 2204.1844517528457, 2204.713387259654, 2204.9559008819815, 2127.0, 2147.806697397234, 2200.3508964855328, 2204.5039866030174, 2208.2712704807454, 2121.9257325993594, 2126.9042893069773, 2132.6907598398225, 2136.4552039229975, 2170.9782902171014, 2127.414960885761, 2136.2736669532433, 2139.326112274644, 2143.774903635127, 2144.0566150893555, 2112.915483380663, 2133.637281662121, 2154.687570302313, 2159.1862835218335, 2170.2946542373793, 7703.653335599855, 7907.525548467111, 7940.444168908179, 7956.920430795733, 7982.082060562993, 4659.650526210514, 4845.515448455161, 4851.805927762921, 4858.46556878743, 4862.343583616202, 2728.140635699748, 2849.7292757188243, 2888.870000849967, 2909.418116376733, 2909.723576260252, 881.9779505512349, 882.9028806831243, 896.2068569316137, 901.9323550733722, 912.1243606138115, 10801.297915635458, 10917.508712107974, 10919.672409827717, 10931.890681093246, 10933.945330273298, 3975.4831871856472, 4124.546299907008, 4271.081717430768, 4272.850450234289, 4298.656107511454, 8496.745097647081, 8540.316774658013, 8547.35894807892, 8553.572321383906, 8554.05905350411, 4704.15325241453, 4706.552877476634, 4707.388039554836, 4707.458642256116, 4711.670183087151, 3742.607026262258, 3882.76703397797, 3999.7200195986, 4354.760488173118, 4374.4531933508315, 3214.7910385825317, 3517.66582174693, 3551.1832278575557, 3586.8565257389414, 3619.258052099366, 1062.2245760594808, 1084.1218612923558, 1097.6103483263487, 1108.6784832398675, 1119.8040342939953, 719.2376081353782, 725.8584576007628, 783.2128710645878, 797.143071198464, 820.5322965909494, 5272.077386457355, 5285.894282114336, 5347.1979203119845, 5518.944810551923, 5870.178175055496, 831.5468069901918, 861.9956900215459, 866.6100254885326, 870.9259712924472, 892.2727976698969, 3354.8490317935753, 3482.9651703483146, 3495.1611613213154, 3546.8226588670464, 3633.1643721943574, 9496.762580935394, 9889.109980101824, 9938.652147174958, 9940.900590994142, 9944.45305508204, 9893.554790034466, 9914.652987145415, 9923.60305587783, 9982.301238913205, 9998.80002399948, 7436.293552112541, 7480.625968701544, 7574.659140338808, 7619.390448764086, 7633.160352361236, 5081.136206844772, 5244.737763111905, 5308.389535203501, 5316.601254905975, 5443.618946673695, 8939.106089391009, 9068.183863452321, 9224.169824715807, 9247.30645201626, 9326.72019839406, 8431.861698670846, 9146.222571081533, 9345.672901448417, 9391.953040234755, 9494.525273736148, 5795.072788354012, 6327.96836015817, 6397.808065758035, 6467.062275970052, 6617.106690596708, 7646.273604007611, 7669.348105411103, 7708.845823083395, 7719.807004824925, 7815.374770018271, 6620.569662971891, 6885.139357580302, 6916.135483064617, 6986.0, 7174.282571742784, 6588.604683718992, 6687.398134167948, 6742.25835158142, 6749.595024298558, 6911.481638877205, 6174.907376389448, 6203.193584833943, 6266.655333956676, 6271.78048768291, 6275.0, 4544.454665440168, 4561.110583436198, 4573.3140028994585, 4618.63050955916, 4652.209124448784, 4650.279206722963, 4652.790624421977, 4676.929846052244, 4684.625229981525, 4790.371353579261], "value": 4125.778860325395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.5046494332334, 287.2101720269261, 292.8887022931286, 293.81196034537885, 299.1295330587989, 4580.839670611529, 4717.481077081518, 4751.691140075897, 4843.878903027422, 4844.975775121124, 4536.115457485792, 4671.416072990876, 4685.50802165772, 4713.740744259065, 4718.504557021506, 3738.12154143776, 3759.6616304532654, 3760.6427389397963, 3762.9811850940705, 3789.9810500947456, 3517.7361697872634, 3668.3396988542054, 3745.288395204916, 3766.8493260269556, 3786.659200671939, 3554.5734511858614, 3700.85196592136, 3700.907477313075, 3704.944425833615, 3717.721170912179, 3688.317661232654, 3695.854285171592, 3697.6302369762807, 3709.870154544578, 3717.739758216926, 3254.9584133077424, 3262.6411094779555, 3279.770416070876, 3283.4746440569634, 3283.4910588858766, 4535.251683472223, 4535.841245556389, 4576.977115114437, 4581.289900065495, 4668.509806470306, 4178.519470260898, 4202.348635961431, 4206.663466922639, 4216.198922204771, 4217.388478670576, 4897.902041959141, 4942.431620363668, 4953.777080031371, 4976.65630279826, 4999.275105109738, 3442.8278586070846, 3572.5355703758346, 3573.910652233689, 3590.5691317042124, 3606.0, 5082.872928176788, 5109.897802043938, 5128.153854613947, 5142.97428512855, 5174.2238664200295, 3631.055925459347, 3636.3272794533095, 3648.7445878788762, 3652.0279049313604, 3661.0481274868725, 3701.796401197906, 3702.962970370316, 3707.94438083429, 3710.6845918097265, 3729.5710993235584, 3946.2896678598127, 4121.814518346681, 4139.81370838313, 4161.563035881189, 4225.577442255812, 4936.901261974812, 4942.283368911488, 4942.975285123552, 4946.530079642428, 4947.604191664658, 1187.8812118788053, 1217.4582310871576, 1220.0239808153442, 1246.2833870524485, 1267.3093164225336, 821.2813787935556, 832.8667413213977, 841.7895526118471, 851.2594043182471, 852.7313896122826, 4354.172707185625, 4362.607365337135, 4386.18855511725, 4390.780460976938, 4400.779961001937, 5042.5628695821515, 5046.7476626168545, 5053.5957123430035, 5054.545090941833, 5058.165402708585, 4349.630281426051, 4365.519792822787, 4367.274926404052, 4373.759443230653, 4374.168907907488, 2315.6191959738635, 2352.941176470602, 2356.9882150589137, 2380.88095595223, 2388.7730665587087, 4185.497740271187, 4218.894527636834, 4227.513835908849, 4238.915221695611, 4277.348044212608, 4564.3838081859185, 4565.977170114128, 4630.699004564693, 4637.768111594474, 4652.0, 4207.8316867325575, 4245.978770106191, 4516.322551617218, 4798.8560343189065, 4825.806967721252, 5115.718635475085, 5121.334226550524, 5125.820596279113, 5130.486951304989, 5140.228965655182, 5013.2981382607195, 5019.196928491424, 5019.24326485727, 5035.29505869186, 5035.546800787946, 4648.8842677757775, 4784.47370789206, 4825.782839772149, 4844.491328410607, 4863.635227357891, 3614.9096272593397, 3621.5473065866768, 3626.4977165755545, 3627.673509384168, 3638.9454158188178, 5098.898022039612, 5112.341582377068, 5119.0, 5127.79488820443, 5131.974340128425, 4598.0, 4723.858284251478, 4805.543473370024, 4833.661643684908, 4949.282354058713, 4924.138275801649, 4977.875553111056, 4984.22744474607, 4989.25161225819, 4991.57571606403, 4870.025994800983, 4873.343063358475, 4874.147024270809, 4881.658283920234, 4887.413510378778, 4794.640401969797, 4915.0, 5011.4487406386, 5012.749362531932, 5027.3464449621315, 4833.734144621939, 4883.194272944925, 4887.141022501876, 4901.877453063702, 4969.304297398439], "value": 3689.1800621061643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.4140211706289, 672.9226138994011, 673.6867356679144, 701.1305980584077, 706.9858602827943, 12650.367481625917, 13709.52016679414, 13719.108257963251, 13721.039527233084, 13728.176309421442, 12328.0, 12435.0, 12441.440135193916, 12458.314792686399, 12747.681307967283, 615.6121643364673, 626.1453116495973, 734.2914087905157, 738.9371903388219, 753.9359154471877, 758.4501236603473, 759.0360242492031, 759.3393747439735, 759.760675387254, 760.5588758520045, 807.4105902691039, 808.2483290539795, 808.3492788305412, 808.6239898447221, 809.0372456776447, 645.4707140145083, 663.9402453779184, 777.3081957058223, 798.2297083314601, 800.7877912353173, 588.7998080652555, 588.8233529941043, 588.8292395205385, 588.9469947704728, 589.0957380421033, 12143.392830358447, 12185.817212741817, 12188.08589355793, 12199.695007624792, 12218.144729868913, 11097.056750176245, 11167.553297868075, 11810.055195584333, 11902.821457678141, 12095.395230238453, 11856.762864742657, 12015.339156346397, 12201.572944946884, 12220.327881966577, 12310.569130080494, 3875.147467557133, 3909.2181563687377, 3910.061585219555, 4100.938485922714, 4102.897427564305, 62967.0, 64534.354656453776, 64885.0, 64908.67545662241, 66289.66855165742, 9176.770580735401, 9260.861087083698, 9272.211342472356, 9385.765355866022, 9419.34064615484, 18100.0, 18180.0, 18243.54391140232, 18435.170417331254, 18451.630967380577, 6000.189974353407, 6202.596831205957, 6459.870802583922, 6489.545731798728, 6827.761028363983, 3505.5618047744033, 3541.734369922266, 3569.5716514017963, 3622.8188590570894, 3644.0322225998193, 2761.875715592763, 2862.742353188223, 2884.4663737208684, 2887.6101726266684, 2893.5225687761285, 467.66561908235775, 471.4554689333825, 483.8596806925952, 486.4624589828189, 490.76933841094626, 451.75379418217153, 498.39942868843684, 502.73103889418985, 503.8513638476585, 526.5287567627029, 7049.3655570997835, 7152.499325047197, 7665.578393188428, 7684.807879803049, 7814.0, 476.80212711724243, 479.95440433158797, 532.7229840483004, 535.6357676779827, 547.690554836524, 3317.5023746437746, 3319.2199833039217, 3340.916477088092, 3374.6287908330064, 3541.11472131967, 88800.0, 95630.0, 101412.49293753484, 101596.0, 103380.48309758403, 49757.25364119541, 60391.69804150951, 85803.14196858076, 86796.5660171695, 90462.54768726115, 58300.0, 71792.0, 77673.61163194147, 78167.60916195382, 78941.0, 6883.6342734822665, 6917.792466226021, 7114.430845532448, 7151.2848715128075, 7460.738874139379, 39161.60838391694, 39550.208995820496, 40035.59964400319, 41518.0, 45747.0, 47735.28397074116, 58571.4142858566, 59531.0, 60841.0, 61123.0, 9866.605335786775, 9998.750031249278, 10046.748831279276, 11046.668599942015, 11179.0, 12408.441620126936, 12597.622071337875, 12686.365681716063, 13468.655881486186, 13479.663008424868, 10735.248532602644, 10871.836922446011, 11228.326300422, 11340.432978351215, 11361.0, 11439.370834603844, 11581.594644187413, 12407.875921240671, 12492.312922789333, 12494.187877787916, 11353.318800871974, 11414.258073225214, 12214.083943704436, 12304.138710290194, 12305.630831075083, 9727.85408218863, 9983.500824958868, 10023.398596084258, 10116.544755485873, 10120.392776433437, 9468.95265523668, 9895.505224738878, 9944.950275248577, 10053.648122315684, 10241.897581024094], "value": 6308.730670029753, "unit": "score"}], "name": "dromaeo_css", "value": 6232.371759142585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 116.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 164.0, 130.0, 124.0, 129.0, 129.0, 162.0, 129.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 164.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 116.0, 78.0, 78.0, 77.0, 76.0, 108.0, 77.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 83.0, 83.0, 118.0, 84.0, 84.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 62.0, 64.0, 63.0, 64.0, 63.0, 64.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 95.0, 83.0, 82.0, 83.0, 81.0, 82.0, 82.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 134.0, 133.0, 134.0, 134.0, 141.0, 132.0, 183.0, 144.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 174.0, 176.0, 173.0, 178.0, 179.0, 177.0, 174.0, 180.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 75.0, 71.0, 76.0, 73.0, 70.0, 70.0, 69.0, 69.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1553.9, "alertThreshold": 2.0}]} 07:43:37 INFO - Return code: 0 07:43:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:43:37 INFO - # TBPL SUCCESS # 07:43:37 INFO - Running post-action listener: _resource_record_post_action 07:43:37 INFO - [mozharness: 2016-09-26 14:43:37.754461Z] Finished run-tests step (success) 07:43:37 INFO - Running post-run listener: _resource_record_post_run 07:43:37 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 2166784; Write bytes: 390021120; Read time: 1188; Write time: 190480 07:43:37 INFO - TinderboxPrint: CPU usage
13.0% 07:43:37 INFO - TinderboxPrint: I/O read bytes / time
2,166,784 / 1,188 07:43:37 INFO - TinderboxPrint: I/O write bytes / time
390,021,120 / 190,480 07:43:37 INFO - TinderboxPrint: CPU idle
8,353.9 (86.9%) 07:43:37 INFO - TinderboxPrint: CPU user
1,204.5 (12.5%) 07:43:37 INFO - TinderboxPrint: Swap in / out
0 / 0 07:43:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99975168; Read time: 0; Write time: 53464 07:43:37 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 2162688; Write bytes: 290045952; Read time: 1168; Write time: 137016 07:43:38 INFO - Running post-run listener: _upload_blobber_files 07:43:38 INFO - Blob upload gear active. 07:43:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:43:38 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:43:38 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:43:38 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:43:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:45 INFO - (blobuploader) - INFO - Done attempting. 07:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:47 INFO - (blobuploader) - INFO - Done attempting. 07:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:48 INFO - (blobuploader) - INFO - Done attempting. 07:43:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:43:48 INFO - Return code: 0 07:43:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:43:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:43:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61a44c39955851441700707d807aedc6a382ef82717279d7a3b19d2d0aa5f62a58bfed1c40605aeee9cbb3793dfb587aacf9c4ee4493236110b3b640f925aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c83d285ce0702e352a433fcce72b7c127c587fc9df0e87252c7d2b6b6e6eaf8d2e724b7a2e7b243b3e504bb3b446690cfb795faa2abb30ca21deaca2b988f18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d52cbd938acd003354e5accf0e150c49301ad807059f97746e79356c9dcc3608323259b2710c9fdff049a91a5108db2260ffe52fbe56d8a0edec2220264ea803"} 07:43:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:43:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:43:48 INFO - Contents: 07:43:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61a44c39955851441700707d807aedc6a382ef82717279d7a3b19d2d0aa5f62a58bfed1c40605aeee9cbb3793dfb587aacf9c4ee4493236110b3b640f925aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c83d285ce0702e352a433fcce72b7c127c587fc9df0e87252c7d2b6b6e6eaf8d2e724b7a2e7b243b3e504bb3b446690cfb795faa2abb30ca21deaca2b988f18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d52cbd938acd003354e5accf0e150c49301ad807059f97746e79356c9dcc3608323259b2710c9fdff049a91a5108db2260ffe52fbe56d8a0edec2220264ea803"} 07:43:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:43:48 INFO - Copying logs to upload dir... 07:43:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:43:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.900322 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-09-26 07:43:47.883928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:43:47.887304) ========= 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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 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/61a44c39955851441700707d807aedc6a382ef82717279d7a3b19d2d0aa5f62a58bfed1c40605aeee9cbb3793dfb587aacf9c4ee4493236110b3b640f925aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c83d285ce0702e352a433fcce72b7c127c587fc9df0e87252c7d2b6b6e6eaf8d2e724b7a2e7b243b3e504bb3b446690cfb795faa2abb30ca21deaca2b988f18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d52cbd938acd003354e5accf0e150c49301ad807059f97746e79356c9dcc3608323259b2710c9fdff049a91a5108db2260ffe52fbe56d8a0edec2220264ea803"} build_url:https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/N4zCZIXbQ8SFoDwiDs6yTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61a44c39955851441700707d807aedc6a382ef82717279d7a3b19d2d0aa5f62a58bfed1c40605aeee9cbb3793dfb587aacf9c4ee4493236110b3b640f925aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c83d285ce0702e352a433fcce72b7c127c587fc9df0e87252c7d2b6b6e6eaf8d2e724b7a2e7b243b3e504bb3b446690cfb795faa2abb30ca21deaca2b988f18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d52cbd938acd003354e5accf0e150c49301ad807059f97746e79356c9dcc3608323259b2710c9fdff049a91a5108db2260ffe52fbe56d8a0edec2220264ea803"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:43:47.913464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:43:47.913963) ========= 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=d2a8c569965ab8367867b893000001a1-1474897884.547562-654966778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:43:47.999368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:43:47.999810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:43:48.000168) ========= ========= Total master_lag: 0.20 =========