builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1474549628.34 results: success (0) buildid: 20160922044603 builduid: 4205a7434d03488ab7a2bceb55eb0993 revision: c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.337056) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.337468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.340797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.382577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.384175) ========= 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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 06:07:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.6M=0s 2016-09-22 06:07:09 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.556057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.556335) ========= 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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.608052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:08.608357) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 --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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 06:07:09,275 truncating revision to first 12 chars 2016-09-22 06:07:09,275 Setting DEBUG logging. 2016-09-22 06:07:09,276 attempt 1/10 2016-09-22 06:07:09,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c448ad05dea9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 06:07:09,583 unpacking tar archive at: autoland-c448ad05dea9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:09.274511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:09.277360) ========= script_repo_revision: c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:09.277804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:09.278110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 06:07:09.288148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-22 06:07:09.288534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:07:10 INFO - MultiFileLogger online at 20160922 06:07:10 in /builds/slave/test 06:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 06:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:10 INFO - {'append_to_log': False, 06:07:10 INFO - 'base_work_dir': '/builds/slave/test', 06:07:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:10 INFO - 'branch': 'Autoland-Non-PGO', 06:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:10 INFO - 'config_files': ('talos/linux_config.py',), 06:07:10 INFO - 'default_actions': ('clobber', 06:07:10 INFO - 'read-buildbot-config', 06:07:10 INFO - 'download-and-extract', 06:07:10 INFO - 'populate-webroot', 06:07:10 INFO - 'create-virtualenv', 06:07:10 INFO - 'install', 06:07:10 INFO - 'run-tests'), 06:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:10 INFO - 'download_minidump_stackwalk': True, 06:07:10 INFO - 'download_symbols': 'ondemand', 06:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:10 INFO - 'installer_path': 'installer.exe', 06:07:10 INFO - 'log_level': 'info', 06:07:10 INFO - 'log_name': 'talos', 06:07:10 INFO - 'log_to_console': True, 06:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:07:10 INFO - 'opt_config_files': (), 06:07:10 INFO - 'pip_index': False, 06:07:10 INFO - 'sps_profile': False, 06:07:10 INFO - 'sps_profile_interval': 0, 06:07:10 INFO - 'suite': 'dromaeojs', 06:07:10 INFO - 'system_bits': '32', 06:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:10 INFO - 'title': 'talos-linux64-ix-050', 06:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:10 INFO - 'use_talos_json': True, 06:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:10 INFO - 'work_dir': 'build'} 06:07:10 INFO - [mozharness: 2016-09-22 13:07:10.048239Z] Running clobber step. 06:07:10 INFO - Running pre-action listener: _resource_record_pre_action 06:07:10 INFO - Running main action method: clobber 06:07:10 INFO - rmtree: /builds/slave/test/build 06:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:10 INFO - Running post-action listener: _resource_record_post_action 06:07:10 INFO - [mozharness: 2016-09-22 13:07:10.506116Z] Finished clobber step (success) 06:07:10 INFO - [mozharness: 2016-09-22 13:07:10.506217Z] Running read-buildbot-config step. 06:07:10 INFO - Running pre-action listener: _resource_record_pre_action 06:07:10 INFO - Running main action method: read_buildbot_config 06:07:10 INFO - Using buildbot properties: 06:07:10 INFO - { 06:07:10 INFO - "project": "", 06:07:10 INFO - "product": "firefox", 06:07:10 INFO - "script_repo_revision": "production", 06:07:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:07:10 INFO - "repository": "", 06:07:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 06:07:10 INFO - "buildid": "20160922044603", 06:07:10 INFO - "pgo_build": "False", 06:07:10 INFO - "basedir": "/builds/slave/test", 06:07:10 INFO - "buildnumber": 619, 06:07:10 INFO - "slavename": "talos-linux64-ix-050", 06:07:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:07:10 INFO - "platform": "ubuntu64_hw", 06:07:10 INFO - "scheduler": "tests-autoland-linux64-talos", 06:07:10 INFO - "branch": "autoland", 06:07:10 INFO - "repo_path": "integration/autoland", 06:07:10 INFO - "revision": "c448ad05dea9dff0ccbbb953ec9b6082b92b6f25", 06:07:10 INFO - "stage_platform": "linux64", 06:07:10 INFO - "builduid": "4205a7434d03488ab7a2bceb55eb0993", 06:07:10 INFO - "slavebuilddir": "test" 06:07:10 INFO - } 06:07:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:07:10 INFO - Running post-action listener: _resource_record_post_action 06:07:10 INFO - [mozharness: 2016-09-22 13:07:10.508690Z] Finished read-buildbot-config step (success) 06:07:10 INFO - [mozharness: 2016-09-22 13:07:10.508780Z] Running download-and-extract step. 06:07:10 INFO - Running pre-action listener: _resource_record_pre_action 06:07:10 INFO - Running main action method: download_and_extract 06:07:10 INFO - mkdir: /builds/slave/test/build/tests 06:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:10 INFO - trying https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:07:10 INFO - Downloading https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/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 06:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/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 06:07:11 INFO - Downloaded 1361 bytes. 06:07:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:07:11 INFO - Using the following test package requirements: 06:07:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:07:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:07:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'jsshell-linux-x86_64.zip'], 06:07:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:07:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:07:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:07:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:07:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:07:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:07:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:07:11 INFO - Expected file size: 20372744 06:07:16 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 06:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:07:17 INFO - Expected file size: 20372744 06:07:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:07:22 INFO - Fetch https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:07:22 INFO - Expected file size: 14414059 06:07:24 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')]} 06:07:24 INFO - trying https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/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 06:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/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 06:07:26 INFO - Downloaded 55705583 bytes. 06:07:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:07:26 INFO - mkdir: /builds/slave/test/properties 06:07:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:07:26 INFO - Writing to file /builds/slave/test/properties/build_url 06:07:26 INFO - Contents: 06:07:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:07:26 INFO - Running post-action listener: _resource_record_post_action 06:07:26 INFO - Running post-action listener: set_extra_try_arguments 06:07:26 INFO - [mozharness: 2016-09-22 13:07:26.771223Z] Finished download-and-extract step (success) 06:07:26 INFO - [mozharness: 2016-09-22 13:07:26.771451Z] Running populate-webroot step. 06:07:26 INFO - Running pre-action listener: _resource_record_pre_action 06:07:26 INFO - Running main action method: populate_webroot 06:07:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:26 INFO - '--tppagecycles', 06:07:26 INFO - '7'], 06:07:26 INFO - 'tests': ['tsvgm']}}, 06:07:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:07:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:07:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['damp', 'tps']}, 06:07:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['damp', 'tps']}, 06:07:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['dromaeo_dom']}, 06:07:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['basic_compositor_video']}, 06:07:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:07:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tsvgx', 06:07:26 INFO - 'tsvgr_opacity', 06:07:26 INFO - 'tart', 06:07:26 INFO - 'tscrollx', 06:07:26 INFO - 'cart']}, 06:07:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:07:26 INFO - 'tsvgr_opacity', 06:07:26 INFO - 'tart', 06:07:26 INFO - 'tscrollx', 06:07:26 INFO - 'cart']}, 06:07:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tp5o']}, 06:07:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['tp5o']}, 06:07:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s', 06:07:26 INFO - '--xperf_path', 06:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:26 INFO - 'tests': ['tp5n']}, 06:07:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--xperf_path', 06:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:26 INFO - 'tests': ['tp5n']}}, 06:07:26 INFO - 'talos.zip': {'path': '', 06:07:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:26 INFO - Running post-action listener: _resource_record_post_action 06:07:26 INFO - [mozharness: 2016-09-22 13:07:26.786998Z] Finished populate-webroot step (success) 06:07:26 INFO - [mozharness: 2016-09-22 13:07:26.787088Z] Running create-virtualenv step. 06:07:26 INFO - Running pre-action listener: _resource_record_pre_action 06:07:26 INFO - Running main action method: create_virtualenv 06:07:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:26 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 06:07:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:26 INFO - Using real prefix '/usr' 06:07:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:29 INFO - Installing pip.................done. 06:07:29 INFO - Return code: 0 06:07:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:07:29 INFO - Using env: {'DISPLAY': ':0', 06:07:29 INFO - 'HOME': '/home/cltbld', 06:07:29 INFO - 'LANG': 'en_US.UTF-8', 06:07:29 INFO - 'LANGUAGE': 'en_US:en', 06:07:29 INFO - 'LOGNAME': 'cltbld', 06:07:29 INFO - 'MAIL': '/var/mail/cltbld', 06:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:29 INFO - 'MOZ_NO_REMOTE': '1', 06:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:29 INFO - 'NO_EM_RESTART': '1', 06:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:29 INFO - 'PWD': '/builds/slave/test', 06:07:29 INFO - 'SHELL': '/bin/bash', 06:07:29 INFO - 'SHLVL': '1', 06:07:29 INFO - 'TERM': 'linux', 06:07:29 INFO - 'TMOUT': '86400', 06:07:29 INFO - 'USER': 'cltbld', 06:07:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:29 INFO - '_': '/tools/buildbot/bin/python'} 06:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:29 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 06:07:29 INFO - Cleaning up... 06:07:29 INFO - Return code: 0 06:07:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:07:29 INFO - Using env: {'DISPLAY': ':0', 06:07:29 INFO - 'HOME': '/home/cltbld', 06:07:29 INFO - 'LANG': 'en_US.UTF-8', 06:07:29 INFO - 'LANGUAGE': 'en_US:en', 06:07:29 INFO - 'LOGNAME': 'cltbld', 06:07:29 INFO - 'MAIL': '/var/mail/cltbld', 06:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:29 INFO - 'MOZ_NO_REMOTE': '1', 06:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:29 INFO - 'NO_EM_RESTART': '1', 06:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:29 INFO - 'PWD': '/builds/slave/test', 06:07:29 INFO - 'SHELL': '/bin/bash', 06:07:29 INFO - 'SHLVL': '1', 06:07:29 INFO - 'TERM': 'linux', 06:07:29 INFO - 'TMOUT': '86400', 06:07:29 INFO - 'USER': 'cltbld', 06:07:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:29 INFO - '_': '/tools/buildbot/bin/python'} 06:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:29 INFO - Downloading/unpacking psutil>=3.1.1 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:31 INFO - Installing collected packages: psutil 06:07:31 INFO - Running setup.py install for psutil 06:07:31 INFO - building 'psutil._psutil_linux' extension 06:07:31 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 06:07:32 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 06:07:32 INFO - building 'psutil._psutil_posix' extension 06:07:32 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 06:07:32 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 06:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:32 INFO - Successfully installed psutil 06:07:32 INFO - Cleaning up... 06:07:32 INFO - Return code: 0 06:07:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:07: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 mozsystemmonitor==0.3 06:07:32 INFO - Using env: {'DISPLAY': ':0', 06:07:32 INFO - 'HOME': '/home/cltbld', 06:07:32 INFO - 'LANG': 'en_US.UTF-8', 06:07:32 INFO - 'LANGUAGE': 'en_US:en', 06:07:32 INFO - 'LOGNAME': 'cltbld', 06:07:32 INFO - 'MAIL': '/var/mail/cltbld', 06:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:32 INFO - 'MOZ_NO_REMOTE': '1', 06:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:32 INFO - 'NO_EM_RESTART': '1', 06:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:32 INFO - 'PWD': '/builds/slave/test', 06:07:32 INFO - 'SHELL': '/bin/bash', 06:07:32 INFO - 'SHLVL': '1', 06:07:32 INFO - 'TERM': 'linux', 06:07:32 INFO - 'TMOUT': '86400', 06:07:32 INFO - 'USER': 'cltbld', 06:07:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:32 INFO - '_': '/tools/buildbot/bin/python'} 06:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:07:34 INFO - Installing collected packages: mozsystemmonitor 06:07:34 INFO - Running setup.py install for mozsystemmonitor 06:07:34 INFO - Successfully installed mozsystemmonitor 06:07:34 INFO - Cleaning up... 06:07:34 INFO - Return code: 0 06:07:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:34 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:34 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 06:07:34 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 06:07:34 INFO - Using env: {'DISPLAY': ':0', 06:07:34 INFO - 'HOME': '/home/cltbld', 06:07:34 INFO - 'LANG': 'en_US.UTF-8', 06:07:34 INFO - 'LANGUAGE': 'en_US:en', 06:07:34 INFO - 'LOGNAME': 'cltbld', 06:07:34 INFO - 'MAIL': '/var/mail/cltbld', 06:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:34 INFO - 'MOZ_NO_REMOTE': '1', 06:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:34 INFO - 'NO_EM_RESTART': '1', 06:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:34 INFO - 'PWD': '/builds/slave/test', 06:07:34 INFO - 'SHELL': '/bin/bash', 06:07:34 INFO - 'SHLVL': '1', 06:07:34 INFO - 'TERM': 'linux', 06:07:34 INFO - 'TMOUT': '86400', 06:07:34 INFO - 'USER': 'cltbld', 06:07:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:34 INFO - '_': '/tools/buildbot/bin/python'} 06:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:07:34 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 06:07:34 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 06:07:34 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 06:07:34 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 06:07:34 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 06:07:34 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 06:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:07:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:07:37 INFO - warning: no files found matching '*.txt' 06:07:37 INFO - no previously-included directories found matching 'build' 06:07:37 INFO - no previously-included directories found matching 'dist' 06:07:37 INFO - no previously-included directories found matching '.git*' 06:07:37 INFO - Installing collected packages: jsonschema, functools32 06:07:37 INFO - Running setup.py install for functools32 06:07:37 INFO - warning: no files found matching '*.txt' 06:07:37 INFO - no previously-included directories found matching 'build' 06:07:37 INFO - no previously-included directories found matching 'dist' 06:07:37 INFO - no previously-included directories found matching '.git*' 06:07:37 INFO - Successfully installed jsonschema functools32 06:07:37 INFO - Cleaning up... 06:07:37 INFO - Return code: 0 06:07:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:37 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:37 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 06:07:37 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 06:07:37 INFO - Using env: {'DISPLAY': ':0', 06:07:37 INFO - 'HOME': '/home/cltbld', 06:07:37 INFO - 'LANG': 'en_US.UTF-8', 06:07:37 INFO - 'LANGUAGE': 'en_US:en', 06:07:37 INFO - 'LOGNAME': 'cltbld', 06:07:37 INFO - 'MAIL': '/var/mail/cltbld', 06:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:37 INFO - 'MOZ_NO_REMOTE': '1', 06:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:37 INFO - 'NO_EM_RESTART': '1', 06:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:37 INFO - 'PWD': '/builds/slave/test', 06:07:37 INFO - 'SHELL': '/bin/bash', 06:07:37 INFO - 'SHLVL': '1', 06:07:37 INFO - 'TERM': 'linux', 06:07:37 INFO - 'TMOUT': '86400', 06:07:37 INFO - 'USER': 'cltbld', 06:07:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:37 INFO - '_': '/tools/buildbot/bin/python'} 06:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:07:37 INFO - Cleaning up... 06:07:37 INFO - Return code: 0 06:07:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:37 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:37 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 06:07:37 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 06:07:37 INFO - Using env: {'DISPLAY': ':0', 06:07:37 INFO - 'HOME': '/home/cltbld', 06:07:37 INFO - 'LANG': 'en_US.UTF-8', 06:07:37 INFO - 'LANGUAGE': 'en_US:en', 06:07:37 INFO - 'LOGNAME': 'cltbld', 06:07:37 INFO - 'MAIL': '/var/mail/cltbld', 06:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:37 INFO - 'MOZ_NO_REMOTE': '1', 06:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:37 INFO - 'NO_EM_RESTART': '1', 06:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:37 INFO - 'PWD': '/builds/slave/test', 06:07:37 INFO - 'SHELL': '/bin/bash', 06:07:37 INFO - 'SHLVL': '1', 06:07:37 INFO - 'TERM': 'linux', 06:07:37 INFO - 'TMOUT': '86400', 06:07:37 INFO - 'USER': 'cltbld', 06:07:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:37 INFO - '_': '/tools/buildbot/bin/python'} 06:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:07:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:07:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:07:40 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 06:07:40 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 06:07:40 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 06:07:40 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 06:07:40 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 06:07:40 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 06:07:40 INFO - Downloading docopt-0.6.1.tar.gz 06:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:07:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:07:40 INFO - Running setup.py install for blobuploader 06:07:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:07:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:07:40 INFO - Running setup.py install for requests 06:07:40 INFO - Running setup.py install for docopt 06:07:40 INFO - Successfully installed blobuploader requests docopt 06:07:40 INFO - Cleaning up... 06:07:40 INFO - Return code: 0 06:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:40 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:40 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 06:07:40 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 06:07:40 INFO - Using env: {'DISPLAY': ':0', 06:07:40 INFO - 'HOME': '/home/cltbld', 06:07:40 INFO - 'LANG': 'en_US.UTF-8', 06:07:40 INFO - 'LANGUAGE': 'en_US:en', 06:07:40 INFO - 'LOGNAME': 'cltbld', 06:07:40 INFO - 'MAIL': '/var/mail/cltbld', 06:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:40 INFO - 'MOZ_NO_REMOTE': '1', 06:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:40 INFO - 'NO_EM_RESTART': '1', 06:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:40 INFO - 'PWD': '/builds/slave/test', 06:07:40 INFO - 'SHELL': '/bin/bash', 06:07:40 INFO - 'SHLVL': '1', 06:07:40 INFO - 'TERM': 'linux', 06:07:40 INFO - 'TMOUT': '86400', 06:07:40 INFO - 'USER': 'cltbld', 06:07:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:40 INFO - '_': '/tools/buildbot/bin/python'} 06:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:41 INFO - Running setup.py (path:/tmp/pip-ezdHgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:41 INFO - Running setup.py (path:/tmp/pip-cC0J_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:41 INFO - Running setup.py (path:/tmp/pip-Fr7q5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:41 INFO - Running setup.py (path:/tmp/pip-qFfOXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:41 INFO - Running setup.py (path:/tmp/pip-27hbHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:41 INFO - Running setup.py (path:/tmp/pip-bJyIEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:41 INFO - Running setup.py (path:/tmp/pip-CgL9MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:41 INFO - Running setup.py (path:/tmp/pip-0CemCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:41 INFO - Running setup.py (path:/tmp/pip-L9TIb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:41 INFO - Running setup.py (path:/tmp/pip-ZqVvCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:41 INFO - Running setup.py (path:/tmp/pip-FemYBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:41 INFO - Running setup.py (path:/tmp/pip-ZoH0kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:42 INFO - Running setup.py (path:/tmp/pip-mTWblg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:42 INFO - Running setup.py (path:/tmp/pip-IkiauC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:42 INFO - Running setup.py (path:/tmp/pip-tskDW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:42 INFO - Running setup.py (path:/tmp/pip-awfFGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:42 INFO - Running setup.py (path:/tmp/pip-anl38m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:07:42 INFO - Running setup.py install for manifestparser 06:07:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozcrash 06:07:42 INFO - Running setup.py install for mozdebug 06:07:42 INFO - Running setup.py install for mozdevice 06:07:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozfile 06:07:42 INFO - Running setup.py install for mozhttpd 06:07:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozinfo 06:07:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozInstall 06:07:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozleak 06:07:43 INFO - Running setup.py install for mozlog 06:07:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for moznetwork 06:07:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozprocess 06:07:43 INFO - Running setup.py install for mozprofile 06:07:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozrunner 06:07:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozscreenshot 06:07:43 INFO - Running setup.py install for moztest 06:07:44 INFO - Running setup.py install for mozversion 06:07:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:07:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:07:44 INFO - Cleaning up... 06:07:44 INFO - Return code: 0 06:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:44 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')]} 06:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:44 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')]} 06:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:44 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:44 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 06:07:44 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 06:07:44 INFO - Using env: {'DISPLAY': ':0', 06:07:44 INFO - 'HOME': '/home/cltbld', 06:07:44 INFO - 'LANG': 'en_US.UTF-8', 06:07:44 INFO - 'LANGUAGE': 'en_US:en', 06:07:44 INFO - 'LOGNAME': 'cltbld', 06:07:44 INFO - 'MAIL': '/var/mail/cltbld', 06:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:44 INFO - 'MOZ_NO_REMOTE': '1', 06:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:44 INFO - 'NO_EM_RESTART': '1', 06:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:44 INFO - 'PWD': '/builds/slave/test', 06:07:44 INFO - 'SHELL': '/bin/bash', 06:07:44 INFO - 'SHLVL': '1', 06:07:44 INFO - 'TERM': 'linux', 06:07:44 INFO - 'TMOUT': '86400', 06:07:44 INFO - 'USER': 'cltbld', 06:07:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:44 INFO - '_': '/tools/buildbot/bin/python'} 06:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:44 INFO - Running setup.py (path:/tmp/pip-hqfsmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:44 INFO - Running setup.py (path:/tmp/pip-XBCd2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:44 INFO - Running setup.py (path:/tmp/pip-I2aBLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:44 INFO - Running setup.py (path:/tmp/pip-Qf5WSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:44 INFO - Running setup.py (path:/tmp/pip-vvImSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:44 INFO - Running setup.py (path:/tmp/pip-RyiK8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:44 INFO - Running setup.py (path:/tmp/pip-7O4uVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:44 INFO - Running setup.py (path:/tmp/pip-hio5xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:44 INFO - Running setup.py (path:/tmp/pip-j0NZWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:45 INFO - Running setup.py (path:/tmp/pip-GH3Eh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:45 INFO - Running setup.py (path:/tmp/pip-uG7sVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:45 INFO - Running setup.py (path:/tmp/pip-TY6uRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:45 INFO - Running setup.py (path:/tmp/pip-9DblTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:45 INFO - Running setup.py (path:/tmp/pip-zhR6BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:45 INFO - Running setup.py (path:/tmp/pip-iDBzK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:45 INFO - Running setup.py (path:/tmp/pip-bUaaGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:45 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)) 06:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:45 INFO - Running setup.py (path:/tmp/pip-KfRwip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:47 INFO - Downloading blessings-1.6.tar.gz 06:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:07:47 INFO - Installing collected packages: blessings 06:07:47 INFO - Running setup.py install for blessings 06:07:47 INFO - Successfully installed blessings 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:47 INFO - Reading from file tmpfile_stdout 06:07:47 INFO - Current package versions: 06:07:47 INFO - argparse == 1.2.1 06:07:47 INFO - blessings == 1.6 06:07:47 INFO - blobuploader == 1.2.4 06:07:47 INFO - docopt == 0.6.1 06:07:47 INFO - functools32 == 3.2.3-2 06:07:47 INFO - jsonschema == 2.5.1 06:07:47 INFO - manifestparser == 1.1 06:07:47 INFO - mozInstall == 1.12 06:07:47 INFO - mozcrash == 0.17 06:07:47 INFO - mozdebug == 0.1 06:07:47 INFO - mozdevice == 0.48 06:07:47 INFO - mozfile == 1.2 06:07:47 INFO - mozhttpd == 0.7 06:07:47 INFO - mozinfo == 0.9 06:07:47 INFO - mozleak == 0.1 06:07:47 INFO - mozlog == 3.4 06:07:47 INFO - moznetwork == 0.27 06:07:47 INFO - mozprocess == 0.23 06:07:47 INFO - mozprofile == 0.28 06:07:47 INFO - mozrunner == 6.12 06:07:47 INFO - mozscreenshot == 0.1 06:07:47 INFO - mozsystemmonitor == 0.3 06:07:47 INFO - moztest == 0.7 06:07:47 INFO - mozversion == 1.4 06:07:47 INFO - psutil == 3.1.1 06:07:47 INFO - requests == 1.2.3 06:07:47 INFO - wsgiref == 0.1.2 06:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:48 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')]} 06:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:48 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:48 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 06:07:48 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 06:07:48 INFO - Using env: {'DISPLAY': ':0', 06:07:48 INFO - 'HOME': '/home/cltbld', 06:07:48 INFO - 'LANG': 'en_US.UTF-8', 06:07:48 INFO - 'LANGUAGE': 'en_US:en', 06:07:48 INFO - 'LOGNAME': 'cltbld', 06:07:48 INFO - 'MAIL': '/var/mail/cltbld', 06:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:48 INFO - 'MOZ_NO_REMOTE': '1', 06:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:48 INFO - 'NO_EM_RESTART': '1', 06:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:48 INFO - 'PWD': '/builds/slave/test', 06:07:48 INFO - 'SHELL': '/bin/bash', 06:07:48 INFO - 'SHLVL': '1', 06:07:48 INFO - 'TERM': 'linux', 06:07:48 INFO - 'TMOUT': '86400', 06:07:48 INFO - 'USER': 'cltbld', 06:07:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:48 INFO - '_': '/tools/buildbot/bin/python'} 06:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 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)) 06:07:48 INFO - Cleaning up... 06:07:48 INFO - Return code: 0 06:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:07:48 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')]} 06:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:48 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')]} 06:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:48 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 0x7f867cf13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', '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 06:07:48 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 06:07:48 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 06:07:48 INFO - Using env: {'DISPLAY': ':0', 06:07:48 INFO - 'HOME': '/home/cltbld', 06:07:48 INFO - 'LANG': 'en_US.UTF-8', 06:07:48 INFO - 'LANGUAGE': 'en_US:en', 06:07:48 INFO - 'LOGNAME': 'cltbld', 06:07:48 INFO - 'MAIL': '/var/mail/cltbld', 06:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:48 INFO - 'MOZ_NO_REMOTE': '1', 06:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:48 INFO - 'NO_EM_RESTART': '1', 06:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:48 INFO - 'PWD': '/builds/slave/test', 06:07:48 INFO - 'SHELL': '/bin/bash', 06:07:48 INFO - 'SHLVL': '1', 06:07:48 INFO - 'TERM': 'linux', 06:07:48 INFO - 'TMOUT': '86400', 06:07:48 INFO - 'USER': 'cltbld', 06:07:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:48 INFO - '_': '/tools/buildbot/bin/python'} 06:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:07:48 INFO - Cleaning up... 06:07:48 INFO - Return code: 0 06:07:48 INFO - Running post-action listener: _resource_record_post_action 06:07:48 INFO - Running post-action listener: _start_resource_monitoring 06:07:48 INFO - Starting resource monitoring. 06:07:48 INFO - [mozharness: 2016-09-22 13:07:48.464460Z] Finished create-virtualenv step (success) 06:07:48 INFO - [mozharness: 2016-09-22 13:07:48.464956Z] Running install step. 06:07:48 INFO - Running pre-action listener: _resource_record_pre_action 06:07:48 INFO - Running main action method: install 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Output received: 06:07:48 INFO - Usage: mozinstall [options] installer 06:07:48 INFO - Options: 06:07:48 INFO - -h, --help show this help message and exit 06:07:48 INFO - -d DEST, --destination=DEST 06:07:48 INFO - Directory to install application into. [default: 06:07:48 INFO - "/builds/slave/test"] 06:07:48 INFO - --app=APP Application being installed. [default: firefox] 06:07:48 INFO - mkdir: /builds/slave/test/build/application 06:07:48 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'] 06:07:48 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 06:08:04 INFO - Reading from file tmpfile_stdout 06:08:04 INFO - Output received: 06:08:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:08:04 INFO - Running post-action listener: _resource_record_post_action 06:08:04 INFO - [mozharness: 2016-09-22 13:08:04.877215Z] Finished install step (success) 06:08:04 INFO - [mozharness: 2016-09-22 13:08:04.877460Z] Running run-tests step. 06:08:04 INFO - Running pre-action listener: _resource_record_pre_action 06:08:04 INFO - Running main action method: run_tests 06:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:04 INFO - Python 2.7.3 06:08:04 INFO - Return code: 0 06:08:04 INFO - grabbing minidump binary from tooltool 06:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:08:04 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 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:04 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 06:08:04 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 06:08:04 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 06:08:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:04 INFO - Return code: 0 06:08:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:08:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:08:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 06:08:04 INFO - Using env: {'DISPLAY': ':0', 06:08:04 INFO - 'HOME': '/home/cltbld', 06:08:04 INFO - 'LANG': 'en_US.UTF-8', 06:08:04 INFO - 'LANGUAGE': 'en_US:en', 06:08:04 INFO - 'LOGNAME': 'cltbld', 06:08:04 INFO - 'MAIL': '/var/mail/cltbld', 06:08:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:04 INFO - 'MOZ_NO_REMOTE': '1', 06:08:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:04 INFO - 'NO_EM_RESTART': '1', 06:08:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:04 INFO - 'PWD': '/builds/slave/test', 06:08:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:04 INFO - 'SHELL': '/bin/bash', 06:08:04 INFO - 'SHLVL': '1', 06:08:04 INFO - 'TERM': 'linux', 06:08:04 INFO - 'TMOUT': '86400', 06:08:04 INFO - 'USER': 'cltbld', 06:08:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126', 06:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:04 INFO - '_': '/tools/buildbot/bin/python'} 06:08:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:08:05 INFO - mozversion application_buildid: 20160922044603 06:08:05 INFO - mozversion application_changeset: c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 06:08:05 INFO - mozversion application_display_name: Nightly 06:08:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:05 INFO - mozversion application_name: Firefox 06:08:05 INFO - mozversion application_remotingname: firefox 06:08:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:08:05 INFO - mozversion application_vendor: Mozilla 06:08:05 INFO - mozversion application_version: 52.0a1 06:08:05 INFO - mozversion platform_buildid: 20160922044603 06:08:05 INFO - mozversion platform_changeset: c448ad05dea9dff0ccbbb953ec9b6082b92b6f25 06:08:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:08:05 INFO - mozversion platform_version: 52.0a1 06:08:05 INFO - using testdate: 1474549685 06:08:05 INFO - actual date: 1474549685 06:08:05 INFO - starting webserver on 'localhost:46117' 06:08:05 INFO - SUITE-START | Running 2 tests 06:08:05 INFO - TEST-START | dromaeo_css 06:08:05 INFO - operating with platform_type : linux_ 06:08:05 INFO - Initialising browser for dromaeo_css test... 06:08:05 INFO - TEST-INFO | started process 23303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4wrMi6/profile http://localhost:46117/getInfo.html) 06:08:09 INFO - PROCESS | 23303 | __metrics Screen width/height:1600/1200 06:08:09 INFO - PROCESS | 23303 | colorDepth:24 06:08:09 INFO - PROCESS | 23303 | Browser inner width/height: 1024/697 06:08:09 INFO - PROCESS | 23303 | __metrics 06:08:09 INFO - PROCESS | 23303 | 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" 06:08:09 INFO - PROCESS | 23303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:10 INFO - PROCESS | 23303 | console.error: PushService: 06:08:10 INFO - PROCESS | 23303 | stateChangeProcessEnqueue: Error transitioning state 06:08:10 INFO - PROCESS | 23303 | UnknownError 06:08:11 INFO - TEST-INFO | 23303: exit 0 06:08:11 INFO - Browser initialized. 06:08:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:11 INFO - TEST-INFO | started process 23384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4wrMi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:23 INFO - PROCESS | 23384 | RSS: Main: 175681536 06:08:23 INFO - PROCESS | 23384 | 06:09:15 INFO - PROCESS | 23384 | 1474549755138 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] 06:11:27 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46117/tests/dromaeo/cssquery-ext.html) 06:11:28 INFO - PROCESS | 23384 | RSS: Main: 287797248 06:11:28 INFO - PROCESS | 23384 | 06:14:31 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-ext.html (next: http://localhost:46117/tests/dromaeo/cssquery-jquery.html) 06:14:31 INFO - PROCESS | 23384 | RSS: Main: 282505216 06:14:31 INFO - PROCESS | 23384 | 06:17:33 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46117/tests/dromaeo/cssquery-mootools.html) 06:17:34 INFO - PROCESS | 23384 | RSS: Main: 221126656 06:17:34 INFO - PROCESS | 23384 | 06:20:36 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46117/tests/dromaeo/cssquery-prototype.html) 06:20:37 INFO - PROCESS | 23384 | RSS: Main: 220205056 06:20:37 INFO - PROCESS | 23384 | 06:23:40 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46117/tests/dromaeo/cssquery-yui.html) 06:23:41 INFO - PROCESS | 23384 | RSS: Main: 219586560 06:23:41 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-yui.html (next: http://localhost:46117/tests/dromaeo/cssquery-dojo.html) 06:26:44 INFO - PROCESS | 23384 | RSS: Main: 313192448 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | __start_tp_report 06:26:44 INFO - PROCESS | 23384 | _x_x_mozilla_page_load 06:26:44 INFO - PROCESS | 23384 | _x_x_mozilla_page_load_details 06:26:44 INFO - PROCESS | 23384 | |i|pagename|runs| 06:26:44 INFO - PROCESS | 23384 | |0;dojo.html;2559.245022718298;2585.146901522498;2609.1911507432696;2615.843049417035;2635.1699214747364;4417.02825378417;4475.731456112636;4624.37570927925;4642.466116396616;4644.233701439262;4496.033352829141;4578.908421831561;4602.401687780583;4613.538646135385;4643.535646435364;4229.1118865038225;4233.809478573472;4258.382534532491;4261.190373828978;4320.740755554677;4267.679924005696;4287.5498072702385;4325.134973005412;4326.156399502099;4377.037051848588;4115.506139263278;4263.275243208631;4278;4296;4372.693911426201;4142.751434913885;4201.558836322203;4213.6839737019845;4258.659307255412;4260.786960651955;4223.303154979425;4224.049588842486;4227.133437645275;4278.443802305712;4281.807318670667;4600.9769951150365;4613.677042607019;4628.32889231063;4634.559716826896;4681.391419115494;4736.692115012514;4795.712257264575;4890.315355850184;4922.335484709554;4957.677750946177;4938.08645400602;4949.604031677457;4952.059108769322;4974.825881094144;5007.198848184309;4600.194965880957;4604.884877878013;4607.608353289975;4610.426840117852;4653.976730116362;4779.4742578317055;4872.805087796449;4912.508749125131;5048.545630893163;5106.795728170906;4761.642876784185;4763.356946812205;4766.618670506351;4814.301926220678;4822.42130944289;4798.376211092535;4799.3041009053495;4804.231322988305;4807.78364973577;4857.198562237262;4665;4706.058788242365;4788.257820037899;4788.569028787426;4854.101991131652;4810.855674329776;4824.228123500223;4856.490068542823;4891.877703057381;4939.3084968104495;4199.2441360555395;4203.222403855236;4208.537060923296;4211.852585159505;4254.7021708480725;3649.3248748981523;3715.4241092630687;3735.1782607826235;3738.9439158412647;3756.6055564165367;4196.979015104905;4200.537940826506;4243.236217480821;4275.957240427556;4307.267764480046;5001.624878134082;5045.495450454925;5046;5053.343065401547;5053.67151135175;4317.56824317572;4323.373110898902;4326.63223625989;4370.7159034662645;4375.081232941055;4525.637948964075;4533.705309154894;4534.274516077412;4534.387857639176;4594.609458196091;4517.728936263835;4554.635629149594;4620.145273124483;4658.557437043475;4715.0473549551725;4872.853814385574;4877.195262781744;4894.290327902363;4917.237828136645;4932.45742968266;4653;4653.53464653532;4655.348251244761;4703.294505824154;4714.198586240279;4627.514111018295;4721.102990431807;4815.975920120517;4817.542333478314;4819.445763737215;4888.144574699342;4910.975445122752;4935.432425271139;4997.550220480174;4998.375203099613;4733.763311834326;4740.9051818962735;4754.215554433618;4772.856814295576;4781.13939490895;4574.725516469022;4642.257238841769;4727.1963766160525;4739.218029025173;4808.447028591617;4600.539946005372;4687.789049492712;4694.929576056294;4699.647526435463;4743.525647435229;4777.0684716479955;4783.928241076317;4784.091022705675;4784.617230621611;4848.3454733611925;4549.68152229354;4673.205555055717;4677.508861569486;4686;4736.5973892219545 06:26:44 INFO - PROCESS | 23384 | |1;ext.html;567.4892596663003;571.7884382778371;577.7400169923535;578.1905332534449;583.9605502206072;27637.17088487346;39080.80459597702;40118.19763604726;40298.79850600743;43382.349264760975;40980.79509602455;41111.79444102783;41179.17641647165;41216;41226.381604275884;7241.6379181041;7715.768526944201;7899.565523896184;7903.0516338039515;7905.525668459911;7254.891176632328;9633.325667203264;9878.160356369717;9882.456464894429;10236;9883.357581757198;9938.602455901755;9939.155171810406;9944.85082723756;9946.353487023356;9844.556994935208;9897.703068907873;9906.108450239513;9926.45404502752;9928.950355248213;9697.709068727949;9765;9767.218622510181;9770.413775173442;9770.853437198448;38226.80886595577;38238.235235295135;38292.425613615815;38299;38376.61623383759;2793.427347393779;2813.535766598509;2828.5050116229577;3081.260497480611;3180.3957248122783;27419.725802741916;28533.144005679864;28571.28571785722;29092.418151636848;30190.396192076256;3471.357798807229;3473.8263086845554;3502.6672466115933;3627.0569651890432;3651.415773476231;247693.76153119298;249500;249624;249832;250043;28127.578086328722;28999.84000639993;52037.2194417084;52325.47674523206;52426.21360679593;31807;31835.363292734015;31978.360432791214;32018.19954501156;32022.67977320197;13017.609471715863;13186.868131318755;13192.538261160813;13206.471741130246;13213.14114582549;8612.698555550525;8827.426217295855;10684.626038088785;10711.410872401937;10762.24664273509;7558.2441755823975;7668.923310766932;7744.961275193588;7754.806129846799;7761.301482866569;3054.3433161870303;3084.7327214497327;3092.505199168122;3107.0678796361003;3128.0615815255787;777.1063277231117;790.083503136359;809.663989444374;881.8809460722848;900.8468560344758;23379.766202338098;25180.748192518207;25317.74682253154;25520.23439296824;25680.229593112235;950.1306304731094;955.2787645327733;962.5379817687549;1038.8130136575337;1046.2885238038207;13422.328883555783;14166.929165354313;14339.713205735827;14342.569722908329;14401.927990360191;121304;594940;612989;613911;617329;49089.50910490921;49611.503884961414;49756.253656195186;49865.25202121971;49896.750516247186;1029.9227557933184;1051.794899994509;1113.8886111388797;1186.9643910682694;1199.8380218670543;24747.381315467257;28657.28356791097;28772.280692982844;29329.706702932697;29532.261693457836;40450;40917;41175;41188.58811411967;41215.175696486505;244274;244996;245258;245268;246302;24243.272701818973;25023.249302520955;25333.493330132926;25385.238442846745;26577;35182.54909060175;35349.469757953135;35403.29193416169;36075;36370.8181459091;34151.146221344665;34364.31271374509;34503.654963451045;34679.826600866836;35451.645483545864;34654.306913862085;34862;35016;35188.64811351854;35555.466667999484;33850.49224261687;34244.315113697085;34605.30789384249;34731.82634086813;35113;26790.866045669645;31624.367512649158;32626.673733262363;33221.33557328791;35713.10717231986;22753;22886.885565572065;22923.88538057299;23124;23172.768272317062 06:26:44 INFO - PROCESS | 23384 | |2;jquery.html;336.7222041815503;347.7791602332518;361.7449697962936;367.19584110797354;385.4738282244735;12304.507819687213;13329.200247985116;15552.066875987448;16541.503754887373;17781.55546111348;16862.494125176232;17007.23467443965;17063.658726825455;17159.227834747435;17181.7422738659;4066.329055705805;4923.655344125904;5123.871903202413;5127.897442051157;5191.247269145972;4976.328195693589;5092.28707980883;5093.770780314876;5097.566706829905;5106.744662766865;4841.426536375692;5001.8249361272365;5072.492750724935;5078.21287700407;5079.898402031957;5036.82371117011;5076.23856421536;5080.314157588715;5085.974570127163;5088.084144853925;4430.933535996963;4455.04216593434;4549.09018196362;4551.658625603093;4553.635709143294;20201.79798202014;20376.592468150553;20445.795542044685;20534.69197962032;20545.794542054537;1782.7147656374918;1797.0565453137076;1800.342874850683;1895.7819850717206;2493.2021753039035;12626.747465050648;12870.678233044155;13077.673058173526;13629.318534073256;13764.587062388144;1673.046363572764;1714.6742118997352;1716;1736.8436840684399;1756.3325936144183;67548.3245167547;67874;68167.31832681708;68195.65902170457;69055.65472172658;8990.325725570608;9221.492817894947;9710.17463515595;9743.805123897624;9765.365251258645;13022.218666880017;13034;13047.282399467931;13047.478100875858;13050.934745326213;6724.394804467622;6883.449324054063;6965.895511567229;7080.256573059857;7174.174969878531;6466.579672321378;6518.804435866931;6658.500612454085;6705.832354191184;6784.118064651564;5786.334571524244;5888.205092312569;5952.166696662471;6042.0969804268025;6060.545459090586;1521.5815650696147;1661.2607389711704;1746.7467217253427;1762.4272111563794;1793.2737241417246;673.9224989126313;744.9180590135081;819.573821612758;861.0184389795638;921.0881227584777;16591.25339359732;16896.32414703398;17467.47597572075;17721;18054.819451805313;799.868021776412;844.1937949258444;855.7304449098514;864.7492227254025;874.5277550122862;9435.716928492018;10198;10223.795524089477;10226.130778883879;10308.433036182932;377546;382321;383889;385861.2017978447;390244;69272.6536367315;69482.30517694859;70602.64698676474;70693.64653176804;70991.2900870995;880.6521424037597;899.4738078224182;903.4940433357209;916.7478943290648;923.930705197113;14622.317382860787;15064.162909379267;15801.525954221392;15901.681966360376;16062.598435039217;29247.561286580294;34673;35598.28803423969;35667.92996210118;36027;45522;45986.54013459956;46619.30071048869;46658.53341466542;46780.29829552492;7190.1371835377995;7238.6018768968215;7362.705491780269;7396.778096657109;7649.502782319131;11085.889141108486;11324.207305488537;11676.357800321064;11850.703732406759;12103.487064116985;10164.542595583365;10242.692719218436;10336.793264134525;10548.208884333551;10677.839832402675;9874.605015799287;10108.94945525297;10285;10304.072633463024;10642.787144257227;10138.138258248131;10265.12746416563;10727.356358618508;10743.677689669323;10787.406692631981;7235.421166306577;7463.253674632493;7726.806829829299;7817.765467035998;8076.757697269091;10002.399856008662;10170.389776613427;10225.642102526375;10426.582936682751;10837.837432438362 06:26:44 INFO - PROCESS | 23384 | |3;mootools.html;1355.268155196194;1383.4950243161245;1426.6789972256245;1653.2642973876623;1655.4371513685344;6598.769043083493;6838.179418469791;7203.747868824586;7743.18696536864;7778.9222107778905;7013;7281.271872812716;7283.562986220817;7475.588842613654;7481.513701609405;2116.2487317002474;2124.2565102214257;2135.29535253366;2140.218820130649;2142.6143294207036;1805.4493379519242;1862.5064357945155;2083.5728675621535;2121.8939053047284;2153.5154590217235;2050.548879246571;2102.348272035666;2120.756113047004;2132.2856842957626;2142.4965133193764;2103.295396042328;2120.766715661284;2130.8401869859745;2153.246363772667;2155.1810312081466;2013.224908410258;2013.9798602013939;2015.3147929703825;2015.7177995080701;2017.4754563813367;7362.153352364439;7424.109106907152;7437.702491900318;7444.627768611548;7587.241275872424;4312.504062032844;4335.848245311399;4410.448693913261;4465.933011004838;4492.528284530143;2847.345110624568;2910.854457277149;2960.304328482805;2965.184574242079;2968;921.7833809054866;927.420362273579;943.2783920300975;948.170350942925;954.7613096725819;10225.079742823107;10231.437270950095;10273.640422585173;10277.075063244343;10279.845802312897;3978;4096.56986016464;4171.457710497616;4188.246115699142;4199.370094485852;7949.403794715419;8074.152214017561;8090.393220508486;8101.351891848638;8109.75670729879;4365.06151177492;4373.978130109329;4376.168527979674;4377.78111094444;4386.122775444924;4029.3955906613655;4069.1251380953236;4072.3484242521645;4074.30736774749;4077.368007958771;3129.6713845045942;3203.4554125798672;3225.854836532362;3243.8864639737494;3248.1554795753273;906.6600024990629;935.1817159985013;951.8239125761756;973.5910917414703;986.9457179855033;757.8938948547208;767.0680123649793;808.3210103513077;830.9626066827008;863.5207459859838;5235.319408476874;5290.894182116336;5361.463853614608;5406.135018397116;5603.327600687943;416.4315709057115;443.1071391146842;445.3320019970045;447.21960179487;599.1127946967089;3517.577890653138;3543.309054734302;3631.092226943264;3649.708023358125;3674.2651469706166;8755.737327880173;9160.954195229115;9175.954120229357;9176.6788162414;9181.357304988587;9124.817503650023;9125.45247285165;9127.041660625671;9128.543572821332;9139.451632902048;6596.967015164893;6789.0834737310815;6897.758578449831;6920.826979325557;6989.685464154125;5185.403678577012;5193.792248310026;5295.523402893604;5304.336957880265;5364.14173732201;8693.695720649746;8779.297656187617;8787.956060219658;8792.956035219782;8876.068012858816;8673.479591224546;8806.251468625238;8838.734837954871;8880.067592902911;8891.244244239311;6578.276389597237;6617.371349721769;6666.200055993312;6719.664016799238;6748.223954245324;7122.964385178041;7222.422206223595;7225.349718525358;7235.457340699574;7237.927620723725;6234.189555357956;6324.083007963727;6325.936740632719;6341.873162536631;6376.043593461018;6303.401176888188;6306.653134077486;6355.682215889279;6402.423781859655;6435.581687190318;6029.397060293935;6198.380161983766;6199.504039676905;6213.813585592439;6219.626822390671;4607.953920460753;4619.607333376701;4621;4699.553542413602;4731.810727570996;4520.954790452053;4527.547245275446;4600.42494688164;4651.372064771348;4795.928061079157 06:26:44 INFO - PROCESS | 23384 | |4;prototype.html;290.6396068874596;292.90334189717396;295.44308977577265;300.57018463597046;304.4307145637655;4825.734584597846;4862.34358361622;4876;4880.341153944217;4885.267209918514;4768.117898188829;4799.664023518355;4817.927731084036;4856.97571512142;4868.440129385113;3571.8928432147077;3679.797611131387;3688.79711615861;3696.3346597612554;3701.2425742821633;3591.2099338145567;3679.319325924699;3695.870644527442;3726.217494326195;3753.0617345663586;3690.874283343579;3708.1841994761107;3712.535933008374;3720.107174278181;3725.143217060078;3617.2042150726797;3709.2766910452474;3712.3317802795486;3727.5154229949935;3738.12154143776;3294.934101317984;3302.339532093591;3303.5705358303267;3309;3313.1551454378978;4639.350490931272;4654.394928659286;4662.440507139131;4702.764861756898;4718.622510199176;4310.374995625617;4318.719283246579;4324.675649326313;4329.9134017319475;4331.956680433187;4788.138135135674;5021.824236151717;5039.571636410909;5054.292399064134;5056.469070747592;3554.5201397811484;3555.093451169961;3556.0931962349696;3557.8221088945706;3560.12776869666;5224.764885580158;5236.921446178349;5263.578913686896;5289.656172348824;5290.153575427951;3524.277523107808;3616.4936908832783;3630.2739452109686;3639.3813051781262;3645.5989841117457;3664.4136938089778;3664.670179683788;3670.9816450917574;3677.3196958562753;3704.944425833615;4221.97889010553;4226.556211597799;4232.809523571446;4238.682098842599;4262.914741705148;4993.704155257586;5009.296839074659;5018.2974383586325;5020.472850350734;5026.798928042837;1198.4846515998204;1257.3838818978634;1262.7348256865978;1265.1460264321547;1265.2155663488695;779.4115442840618;779.9103103143098;811.4644334739162;817.37062461904;823.1603764160523;3977.960220397817;4277.251480990814;4404.427424434867;4414.227510185705;4538.750368729686;5116.948830511722;5146.253793199965;5166.095933211673;5225.973870130625;5230.476952304739;4453.242948698729;4470.719932834278;4472.396226509444;4483.977580112079;4514.345419914094;2646.563317052665;2726.6864310604137;2730.6313647657707;2762.654668166479;2763.5301998660275;4919.458859525449;4922.458529561745;4928.753562321869;4947.282644016597;4948.529889660476;5241.73791310433;5258.553022993012;5278.234655974862;5282.31329927107;5302.893942121136;4689.3903792507435;4878.170710979142;4911.926321105187;4923.8921242721535;4976.825811096594;5139.434662187082;5143.871403214949;5170.948290517047;5187.922181167361;5194.662346947436;4923.753812309298;5080.8221712241375;5082.796688132581;5093.337866077386;5105.693658380361;4873.46391896884;4913.459519452929;4915.26271059344;4927.334809800631;4938.148244369398;3573.6426357364057;3575.8927232183078;3578;3581.1942312980414;3583.1009564930628;5138.537531622172;5165.380154381498;5168.147255702767;5181.792728290826;5197.506236907488;4782.426108866958;5000.199888062696;5004.049230646166;5014.57376123019;5026.447090819934;4989.875253118701;5014.395393474053;5015.473375295542;5024.799008039638;5034.2951986721155;4940.814204590944;4954.479779623088;4959.975200123977;4965.97517012427;4986.775595098156;4839.540243676845;4857.854264372075;4992.400911890451;5065.696058236517;5095.541401273903;4800.399950006249;4890.975545122252;4968.155413579772;4971.627127965489;4981.825636102864 06:26:44 INFO - PROCESS | 23384 | |5;yui.html;568.2527476368576;592.7391947543081;658.0096954084103;665.5407768639635;697.7488104282454;11344.943275283622;12572.497100116007;12626.30555319457;12631.936840315808;12660.556880509184;11428.599999000036;11503.712407189803;11513.194076414655;11513.942430287836;11545.134114941391;589.9557533185007;609.2810483629315;724.6557885004607;728.0317178153057;753.1790348520112;747.2938073520526;751.29003092078;759.5518644000039;760.2853317881202;760.52467207995;632.1529150937743;803.6664784114586;805.2068712318362;805.3235282362814;805.7059173401695;640.3756337570878;771.1247733822124;779.6413649721135;787.7557957033338;798.1659166171307;585.066818424612;586.0242695911345;586.4809643465521;586.6568057686259;586.6656006076538;11113.888861111367;11162.274452160584;11203.607873724462;11338.149638777124;11713.941430292794;12179.451924663323;12469.501219951191;12673.683157921034;12790.936045319806;13190.406431710597;9356.625734970594;9468.621255149787;9649.228061755042;9978.800423991552;10460.895391046068;3851.287511810324;3860.1893602343544;3961.702872284561;3968.6981550700525;3972.960270397317;52463.47536524624;54091.72954135204;54788;59127.40872591262;60437;10333.431661258703;10422.426766527913;10599.205059620559;10695.625653102104;10984.395858227714;19573.60852782965;19585.804141958684;19591.510212244808;19600.901995490218;19602.803971960384;6952.443804495628;6956.8956465653055;7166.53417527859;7314.597697126603;7325.450591205575;3452.4476083826466;3537.2041290709385;3543.3799085159994;3565.5721313442555;3695.2055308108347;2805.5511118221393;2911.301287690981;2912.985435072811;2923.473774720571;2924.8391338476163;489.2338657446615;494.1007366592838;502.32939026400163;504.60388594952786;508.217345288252;527.3961314295111;538.0610834094452;574.8074395077613;590.4951266666937;609.3206075226091;6597.80206593803;6722.327767223239;7033.964830175816;7035.904202151037;8050.56950325005;565.5786439102894;568.4679787971378;580.160682728338;587.3157771196594;592.1916583863082;3788.3559794834946;3893.980530097331;3955.7033222508426;3983.063979964706;4092.07928216149;57599;58377.124343134885;95966.52016739872;104304;108111.48606424197;88780;88845.11154888498;89182;89626.55186724155;90763.54618226999;45038.54961450409;46138.769306153925;46261.768691157675;58799;74766.25233747593;7155;7280.765515936573;7363.558186508827;7586.165521792709;7617.619119044137;31270.374592507567;31912.202194945312;33443.498347525296;40388.79805600953;43143.13713725645;59260.70369648124;61343.38656613555;68437.65781171063;70985;71131;9559.569819358006;9695.66065187715;9777.657781977881;9870.161036311707;10054.64808731691;9275.07249275067;9554.761130971781;10496.68509944703;10579.576816927236;10798.622048228588;9644.614215431304;9817.803643926938;10040.748981275527;10144.898551014396;10164.085232329126;10125.64560240388;10235.539400726837;10373.377597343882;10387.324823886423;10417.322874013165;9953.402795832273;9986.35088719231;10186.796264074528;10249.33379330341;10718.410487423267;8393.916060839314;8738.868916966123;8782.868256976279;8783.824323513621;9013.143751343612;8389.580520973805;8424.705135320235;8590.14098590136;8614.18165274298;8775.297976162019 06:26:44 INFO - PROCESS | 23384 | __end_tp_report 06:26:44 INFO - PROCESS | 23384 | __start_cc_report 06:26:44 INFO - PROCESS | 23384 | _x_x_mozilla_cycle_collect,1024 06:26:44 INFO - PROCESS | 23384 | __end_cc_report 06:26:44 INFO - PROCESS | 23384 | __startTimestamp1474550804409__endTimestamp 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | ------- Summary: start ------- 06:26:44 INFO - PROCESS | 23384 | Number of tests: 6 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#0] dojo.html Cycles:165 Average:4542.27 Median:4653.53 stddev:451.60 (9.7%) stddev-sans-first:425.35 06:26:44 INFO - PROCESS | 23384 | Values: 2559.2 2585.1 2609.2 2615.8 2635.2 4417.0 4475.7 4624.4 4642.5 4644.2 4496.0 4578.9 4602.4 4613.5 4643.5 4229.1 4233.8 4258.4 4261.2 4320.7 4267.7 4287.5 4325.1 4326.2 4377.0 4115.5 4263.3 4278.0 4296.0 4372.7 4142.8 4201.6 4213.7 4258.7 4260.8 4223.3 4224.0 4227.1 4278.4 4281.8 4601.0 4613.7 4628.3 4634.6 4681.4 4736.7 4795.7 4890.3 4922.3 4957.7 4938.1 4949.6 4952.1 4974.8 5007.2 4600.2 4604.9 4607.6 4610.4 4654.0 4779.5 4872.8 4912.5 5048.5 5106.8 4761.6 4763.4 4766.6 4814.3 4822.4 4798.4 4799.3 4804.2 4807.8 4857.2 4665.0 4706.1 4788.3 4788.6 4854.1 4810.9 4824.2 4856.5 4891.9 4939.3 4199.2 4203.2 4208.5 4211.9 4254.7 3649.3 3715.4 3735.2 3738.9 3756.6 4197.0 4200.5 4243.2 4276.0 4307.3 5001.6 5045.5 5046.0 5053.3 5053.7 4317.6 4323.4 4326.6 4370.7 4375.1 4525.6 4533.7 4534.3 4534.4 4594.6 4517.7 4554.6 4620.1 4658.6 4715.0 4872.9 4877.2 4894.3 4917.2 4932.5 4653.0 4653.5 4655.3 4703.3 4714.2 4627.5 4721.1 4816.0 4817.5 4819.4 4888.1 4911.0 4935.4 4997.6 4998.4 4733.8 4740.9 4754.2 4772.9 4781.1 4574.7 4642.3 4727.2 4739.2 4808.4 4600.5 4687.8 4694.9 4699.6 4743.5 4777.1 4783.9 4784.1 4784.6 4848.3 4549.7 4673.2 4677.5 4686.0 4736.6 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#1] ext.html Cycles:180 Average:47121.48 Median:34939.00 stddev:100969.10 (289.0%) stddev-sans-first:101191.85 06:26:44 INFO - PROCESS | 23384 | Values: 567.5 571.8 577.7 578.2 584.0 27637.2 39080.8 40118.2 40298.8 43382.3 40980.8 41111.8 41179.2 41216.0 41226.4 7241.6 7715.8 7899.6 7903.1 7905.5 7254.9 9633.3 9878.2 9882.5 10236.0 9883.4 9938.6 9939.2 9944.9 9946.4 9844.6 9897.7 9906.1 9926.5 9929.0 9697.7 9765.0 9767.2 9770.4 9770.9 38226.8 38238.2 38292.4 38299.0 38376.6 2793.4 2813.5 2828.5 3081.3 3180.4 27419.7 28533.1 28571.3 29092.4 30190.4 3471.4 3473.8 3502.7 3627.1 3651.4 247693.8 249500.0 249624.0 249832.0 250043.0 28127.6 28999.8 52037.2 52325.5 52426.2 31807.0 31835.4 31978.4 32018.2 32022.7 13017.6 13186.9 13192.5 13206.5 13213.1 8612.7 8827.4 10684.6 10711.4 10762.2 7558.2 7668.9 7745.0 7754.8 7761.3 3054.3 3084.7 3092.5 3107.1 3128.1 777.1 790.1 809.7 881.9 900.8 23379.8 25180.7 25317.7 25520.2 25680.2 950.1 955.3 962.5 1038.8 1046.3 13422.3 14166.9 14339.7 14342.6 14401.9 121304.0 594940.0 612989.0 613911.0 617329.0 49089.5 49611.5 49756.3 49865.3 49896.8 1029.9 1051.8 1113.9 1187.0 1199.8 24747.4 28657.3 28772.3 29329.7 29532.3 40450.0 40917.0 41175.0 41188.6 41215.2 244274.0 244996.0 245258.0 245268.0 246302.0 24243.3 25023.2 25333.5 25385.2 26577.0 35182.5 35349.5 35403.3 36075.0 36370.8 34151.1 34364.3 34503.7 34679.8 35451.6 34654.3 34862.0 35016.0 35188.6 35555.5 33850.5 34244.3 34605.3 34731.8 35113.0 26790.9 31624.4 32626.7 33221.3 35713.1 22753.0 22886.9 22923.9 23124.0 23172.8 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#2] jquery.html Cycles:180 Average:23740.03 Median:193123.34 stddev:63206.08 (32.7%) stddev-sans-first:63358.96 06:26:44 INFO - PROCESS | 23384 | Values: 336.7 347.8 361.7 367.2 385.5 12304.5 13329.2 15552.1 16541.5 17781.6 16862.5 17007.2 17063.7 17159.2 17181.7 4066.3 4923.7 5123.9 5127.9 5191.2 4976.3 5092.3 5093.8 5097.6 5106.7 4841.4 5001.8 5072.5 5078.2 5079.9 5036.8 5076.2 5080.3 5086.0 5088.1 4430.9 4455.0 4549.1 4551.7 4553.6 20201.8 20376.6 20445.8 20534.7 20545.8 1782.7 1797.1 1800.3 1895.8 2493.2 12626.7 12870.7 13077.7 13629.3 13764.6 1673.0 1714.7 1716.0 1736.8 1756.3 67548.3 67874.0 68167.3 68195.7 69055.7 8990.3 9221.5 9710.2 9743.8 9765.4 13022.2 13034.0 13047.3 13047.5 13050.9 6724.4 6883.4 6965.9 7080.3 7174.2 6466.6 6518.8 6658.5 6705.8 6784.1 5786.3 5888.2 5952.2 6042.1 6060.5 1521.6 1661.3 1746.7 1762.4 1793.3 673.9 744.9 819.6 861.0 921.1 16591.3 16896.3 17467.5 17721.0 18054.8 799.9 844.2 855.7 864.7 874.5 9435.7 10198.0 10223.8 10226.1 10308.4 377546.0 382321.0 383889.0 385861.2 390244.0 69272.7 69482.3 70602.6 70693.6 70991.3 880.7 899.5 903.5 916.7 923.9 14622.3 15064.2 15801.5 15901.7 16062.6 29247.6 34673.0 35598.3 35667.9 36027.0 45522.0 45986.5 46619.3 46658.5 46780.3 7190.1 7238.6 7362.7 7396.8 7649.5 11085.9 11324.2 11676.4 11850.7 12103.5 10164.5 10242.7 10336.8 10548.2 10677.8 9874.6 10108.9 10285.0 10304.1 10642.8 10138.1 10265.1 10727.4 10743.7 10787.4 7235.4 7463.3 7726.8 7817.8 8076.8 10002.4 10170.4 10225.6 10426.6 10837.8 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#3] mootools.html Cycles:180 Average:4927.67 Median:5362.80 stddev:2749.07 (51.3%) stddev-sans-first:2743.67 06:26:44 INFO - PROCESS | 23384 | Values: 1355.3 1383.5 1426.7 1653.3 1655.4 6598.8 6838.2 7203.7 7743.2 7778.9 7013.0 7281.3 7283.6 7475.6 7481.5 2116.2 2124.3 2135.3 2140.2 2142.6 1805.4 1862.5 2083.6 2121.9 2153.5 2050.5 2102.3 2120.8 2132.3 2142.5 2103.3 2120.8 2130.8 2153.2 2155.2 2013.2 2014.0 2015.3 2015.7 2017.5 7362.2 7424.1 7437.7 7444.6 7587.2 4312.5 4335.8 4410.4 4465.9 4492.5 2847.3 2910.9 2960.3 2965.2 2968.0 921.8 927.4 943.3 948.2 954.8 10225.1 10231.4 10273.6 10277.1 10279.8 3978.0 4096.6 4171.5 4188.2 4199.4 7949.4 8074.2 8090.4 8101.4 8109.8 4365.1 4374.0 4376.2 4377.8 4386.1 4029.4 4069.1 4072.3 4074.3 4077.4 3129.7 3203.5 3225.9 3243.9 3248.2 906.7 935.2 951.8 973.6 986.9 757.9 767.1 808.3 831.0 863.5 5235.3 5290.9 5361.5 5406.1 5603.3 416.4 443.1 445.3 447.2 599.1 3517.6 3543.3 3631.1 3649.7 3674.3 8755.7 9161.0 9176.0 9176.7 9181.4 9124.8 9125.5 9127.0 9128.5 9139.5 6597.0 6789.1 6897.8 6920.8 6989.7 5185.4 5193.8 5295.5 5304.3 5364.1 8693.7 8779.3 8788.0 8793.0 8876.1 8673.5 8806.3 8838.7 8880.1 8891.2 6578.3 6617.4 6666.2 6719.7 6748.2 7123.0 7222.4 7225.3 7235.5 7237.9 6234.2 6324.1 6325.9 6341.9 6376.0 6303.4 6306.7 6355.7 6402.4 6435.6 6029.4 6198.4 6199.5 6213.8 6219.6 4608.0 4619.6 4621.0 4699.6 4731.8 4521.0 4527.5 4600.4 4651.4 4795.9 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#4] prototype.html Cycles:180 Average:4165.73 Median:4809.16 stddev:1225.03 (25.5%) stddev-sans-first:1193.44 06:26:44 INFO - PROCESS | 23384 | Values: 290.6 292.9 295.4 300.6 304.4 4825.7 4862.3 4876.0 4880.3 4885.3 4768.1 4799.7 4817.9 4857.0 4868.4 3571.9 3679.8 3688.8 3696.3 3701.2 3591.2 3679.3 3695.9 3726.2 3753.1 3690.9 3708.2 3712.5 3720.1 3725.1 3617.2 3709.3 3712.3 3727.5 3738.1 3294.9 3302.3 3303.6 3309.0 3313.2 4639.4 4654.4 4662.4 4702.8 4718.6 4310.4 4318.7 4324.7 4329.9 4332.0 4788.1 5021.8 5039.6 5054.3 5056.5 3554.5 3555.1 3556.1 3557.8 3560.1 5224.8 5236.9 5263.6 5289.7 5290.2 3524.3 3616.5 3630.3 3639.4 3645.6 3664.4 3664.7 3671.0 3677.3 3704.9 4222.0 4226.6 4232.8 4238.7 4262.9 4993.7 5009.3 5018.3 5020.5 5026.8 1198.5 1257.4 1262.7 1265.1 1265.2 779.4 779.9 811.5 817.4 823.2 3978.0 4277.3 4404.4 4414.2 4538.8 5116.9 5146.3 5166.1 5226.0 5230.5 4453.2 4470.7 4472.4 4484.0 4514.3 2646.6 2726.7 2730.6 2762.7 2763.5 4919.5 4922.5 4928.8 4947.3 4948.5 5241.7 5258.6 5278.2 5282.3 5302.9 4689.4 4878.2 4911.9 4923.9 4976.8 5139.4 5143.9 5170.9 5187.9 5194.7 4923.8 5080.8 5082.8 5093.3 5105.7 4873.5 4913.5 4915.3 4927.3 4938.1 3573.6 3575.9 3578.0 3581.2 3583.1 5138.5 5165.4 5168.1 5181.8 5197.5 4782.4 5000.2 5004.0 5014.6 5026.4 4989.9 5014.4 5015.5 5024.8 5034.3 4940.8 4954.5 4960.0 4966.0 4986.8 4839.5 4857.9 4992.4 5065.7 5095.5 4800.4 4891.0 4968.2 4971.6 4981.8 06:26:44 INFO - PROCESS | 23384 | 06:26:44 INFO - PROCESS | 23384 | [#5] yui.html Cycles:180 Average:16229.98 Median:29089.58 stddev:23766.97 (81.7%) stddev-sans-first:23804.55 06:26:44 INFO - PROCESS | 23384 | Values: 568.3 592.7 658.0 665.5 697.7 11344.9 12572.5 12626.3 12631.9 12660.6 11428.6 11503.7 11513.2 11513.9 11545.1 590.0 609.3 724.7 728.0 753.2 747.3 751.3 759.6 760.3 760.5 632.2 803.7 805.2 805.3 805.7 640.4 771.1 779.6 787.8 798.2 585.1 586.0 586.5 586.7 586.7 11113.9 11162.3 11203.6 11338.1 11713.9 12179.5 12469.5 12673.7 12790.9 13190.4 9356.6 9468.6 9649.2 9978.8 10460.9 3851.3 3860.2 3961.7 3968.7 3973.0 52463.5 54091.7 54788.0 59127.4 60437.0 10333.4 10422.4 10599.2 10695.6 10984.4 19573.6 19585.8 19591.5 19600.9 19602.8 6952.4 6956.9 7166.5 7314.6 7325.5 3452.4 3537.2 3543.4 3565.6 3695.2 2805.6 2911.3 2913.0 2923.5 2924.8 489.2 494.1 502.3 504.6 508.2 527.4 538.1 574.8 590.5 609.3 6597.8 6722.3 7034.0 7035.9 8050.6 565.6 568.5 580.2 587.3 592.2 3788.4 3894.0 3955.7 3983.1 4092.1 57599.0 58377.1 95966.5 104304.0 108111.5 88780.0 88845.1 89182.0 89626.6 90763.5 45038.5 46138.8 46261.8 58799.0 74766.3 7155.0 7280.8 7363.6 7586.2 7617.6 31270.4 31912.2 33443.5 40388.8 43143.1 59260.7 61343.4 68437.7 70985.0 71131.0 9559.6 9695.7 9777.7 9870.2 10054.6 9275.1 9554.8 10496.7 10579.6 10798.6 9644.6 9817.8 10040.7 10144.9 10164.1 10125.6 10235.5 10373.4 10387.3 10417.3 9953.4 9986.4 10186.8 10249.3 10718.4 8393.9 8738.9 8782.9 8783.8 9013.1 8389.6 8424.7 8590.1 8614.2 8775.3 06:26:44 INFO - PROCESS | 23384 | -------- Summary: end -------- 06:26:44 INFO - PROCESS | 23384 | 06:26:45 INFO - TEST-INFO | 23384: exit 0 06:26:45 INFO - TEST-OK | dromaeo_css | took 1120267ms 06:26:45 INFO - TEST-START | kraken 06:26:45 INFO - operating with platform_type : linux_ 06:26:45 INFO - Initialising browser for kraken test... 06:26:45 INFO - TEST-INFO | started process 23691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbxOOQ/profile http://localhost:46117/getInfo.html) 06:26:49 INFO - PROCESS | 23691 | __metrics Screen width/height:1600/1200 06:26:49 INFO - PROCESS | 23691 | colorDepth:24 06:26:49 INFO - PROCESS | 23691 | Browser inner width/height: 1024/697 06:26:49 INFO - PROCESS | 23691 | __metrics 06:26:50 INFO - PROCESS | 23691 | 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" 06:26:50 INFO - PROCESS | 23691 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:50 INFO - PROCESS | 23691 | console.error: PushService: 06:26:50 INFO - PROCESS | 23691 | stateChangeProcessEnqueue: Error transitioning state 06:26:50 INFO - PROCESS | 23691 | UnknownError 06:26:51 INFO - TEST-INFO | 23691: exit 0 06:26:51 INFO - Browser initialized. 06:26:51 INFO - Running cycle 1/1 for kraken test... 06:26:51 INFO - TEST-INFO | started process 23772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbxOOQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:03 INFO - PROCESS | 23772 | RSS: Main: 175861760 06:27:03 INFO - PROCESS | 23772 | 06:27:06 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection) 06:27:07 INFO - PROCESS | 23772 | RSS: Main: 243433472 06:27:07 INFO - PROCESS | 23772 | 06:27:10 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-dft) 06:27:11 INFO - PROCESS | 23772 | RSS: Main: 218820608 06:27:11 INFO - PROCESS | 23772 | 06:27:14 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-fft) 06:27:14 INFO - PROCESS | 23772 | RSS: Main: 301096960 06:27:14 INFO - PROCESS | 23772 | 06:27:17 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator) 06:27:17 INFO - PROCESS | 23772 | RSS: Main: 210644992 06:27:17 INFO - PROCESS | 23772 | 06:27:19 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:20 INFO - PROCESS | 23772 | RSS: Main: 214568960 06:27:20 INFO - PROCESS | 23772 | 06:27:23 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom) 06:27:24 INFO - PROCESS | 23772 | RSS: Main: 250580992 06:27:24 INFO - PROCESS | 23772 | 06:27:27 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate) 06:27:28 INFO - PROCESS | 23772 | RSS: Main: 249778176 06:27:28 INFO - PROCESS | 23772 | 06:27:31 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial) 06:27:31 INFO - PROCESS | 23772 | RSS: Main: 249716736 06:27:31 INFO - PROCESS | 23772 | 06:27:33 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:27:34 INFO - PROCESS | 23772 | RSS: Main: 212574208 06:27:34 INFO - PROCESS | 23772 | 06:27:36 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:27:36 INFO - PROCESS | 23772 | RSS: Main: 219672576 06:27:36 INFO - PROCESS | 23772 | 06:27:38 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:27:39 INFO - PROCESS | 23772 | RSS: Main: 224100352 06:27:39 INFO - PROCESS | 23772 | 06:27:42 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:27:43 INFO - PROCESS | 23772 | RSS: Main: 224894976 06:27:43 INFO - PROCESS | 23772 | 06:27:46 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:27:46 INFO - PROCESS | 23772 | RSS: Main: 222457856 06:27:46 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46117/tests/kraken/driver.html?testName=ai-astar) 06:27:48 INFO - PROCESS | 23772 | RSS: Main: 273117184 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | __start_tp_report 06:27:48 INFO - PROCESS | 23772 | _x_x_mozilla_page_load 06:27:48 INFO - PROCESS | 23772 | _x_x_mozilla_page_load_details 06:27:48 INFO - PROCESS | 23772 | |i|pagename|runs| 06:27:48 INFO - PROCESS | 23772 | |0;ai-astar;114;117;115;117;115;115;114;115;115;115 06:27:48 INFO - PROCESS | 23772 | |1;audio-beat-detection;157;130;124;167;125;126;125;125;168;130 06:27:48 INFO - PROCESS | 23772 | |2;audio-dft;161;160;161;162;162;161;160;161;160;159 06:27:48 INFO - PROCESS | 23772 | |3;audio-fft;76;76;77;102;78;76;77;75;108;76 06:27:48 INFO - PROCESS | 23772 | |4;audio-oscillator;85;84;119;85;85;83;121;84;84;126 06:27:48 INFO - PROCESS | 23772 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;117;117 06:27:48 INFO - PROCESS | 23772 | |6;imaging-darkroom;148;147;148;147;147;148;147;147;147;147 06:27:48 INFO - PROCESS | 23772 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;95 06:27:48 INFO - PROCESS | 23772 | |8;json-parse-financial;65;64;64;64;66;67;66;66;66;65 06:27:48 INFO - PROCESS | 23772 | |9;json-stringify-tinderbox;66;66;66;66;67;66;67;66;66;67 06:27:48 INFO - PROCESS | 23772 | |10;stanford-crypto-aes;84;82;83;84;83;84;83;84;83;84 06:27:48 INFO - PROCESS | 23772 | |11;stanford-crypto-ccm;136;132;137;134;141;132;134;131;180;131 06:27:48 INFO - PROCESS | 23772 | |12;stanford-crypto-pbkdf2;177;176;172;175;176;177;180;176;173;179 06:27:48 INFO - PROCESS | 23772 | |13;stanford-crypto-sha256-iterative;75;70;74;70;70;70;70;71;70;69 06:27:48 INFO - PROCESS | 23772 | __end_tp_report 06:27:48 INFO - PROCESS | 23772 | __start_cc_report 06:27:48 INFO - PROCESS | 23772 | _x_x_mozilla_cycle_collect,1926 06:27:48 INFO - PROCESS | 23772 | __end_cc_report 06:27:48 INFO - PROCESS | 23772 | __startTimestamp1474550868741__endTimestamp 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | ------- Summary: start ------- 06:27:48 INFO - PROCESS | 23772 | Number of tests: 14 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 06:27:48 INFO - PROCESS | 23772 | Values: 114.0 117.0 115.0 117.0 115.0 115.0 114.0 115.0 115.0 115.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:130.00 stddev:18.49 (14.2%) stddev-sans-first:18.24 06:27:48 INFO - PROCESS | 23772 | Values: 157.0 130.0 124.0 167.0 125.0 126.0 125.0 125.0 168.0 130.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 06:27:48 INFO - PROCESS | 23772 | Values: 161.0 160.0 161.0 162.0 162.0 161.0 160.0 161.0 160.0 159.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.18 (16.0%) stddev-sans-first:12.72 06:27:48 INFO - PROCESS | 23772 | Values: 76.0 76.0 77.0 102.0 78.0 76.0 77.0 75.0 108.0 76.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:18.31 (21.8%) stddev-sans-first:19.01 06:27:48 INFO - PROCESS | 23772 | Values: 85.0 84.0 119.0 85.0 85.0 83.0 121.0 84.0 84.0 126.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:27:48 INFO - PROCESS | 23772 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:27:48 INFO - PROCESS | 23772 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:27:48 INFO - PROCESS | 23772 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 06:27:48 INFO - PROCESS | 23772 | Values: 65.0 64.0 64.0 64.0 66.0 67.0 66.0 66.0 66.0 65.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 06:27:48 INFO - PROCESS | 23772 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 67.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 06:27:48 INFO - PROCESS | 23772 | Values: 84.0 82.0 83.0 84.0 83.0 84.0 83.0 84.0 83.0 84.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:135.00 stddev:14.81 (11.0%) stddev-sans-first:15.67 06:27:48 INFO - PROCESS | 23772 | Values: 136.0 132.0 137.0 134.0 141.0 132.0 134.0 131.0 180.0 131.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:176.50 stddev:2.42 (1.4%) stddev-sans-first:2.55 06:27:48 INFO - PROCESS | 23772 | Values: 177.0 176.0 172.0 175.0 176.0 177.0 180.0 176.0 173.0 179.0 06:27:48 INFO - PROCESS | 23772 | 06:27:48 INFO - PROCESS | 23772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:1.42 06:27:48 INFO - PROCESS | 23772 | Values: 75.0 70.0 74.0 70.0 70.0 70.0 70.0 71.0 70.0 69.0 06:27:48 INFO - PROCESS | 23772 | -------- Summary: end -------- 06:27:48 INFO - PROCESS | 23772 | 06:27:50 INFO - TEST-INFO | 23772: exit 0 06:27:50 INFO - TEST-OK | kraken | took 64799ms 06:27:50 INFO - SUITE-END | took 1185s 06:27:50 INFO - Completed test suite (00:19:45) 06:27:50 INFO - javascript benchmark 06:27:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2559.245022718298, 2585.146901522498, 2609.1911507432696, 2615.843049417035, 2635.1699214747364, 4417.02825378417, 4475.731456112636, 4624.37570927925, 4642.466116396616, 4644.233701439262, 4496.033352829141, 4578.908421831561, 4602.401687780583, 4613.538646135385, 4643.535646435364, 4229.1118865038225, 4233.809478573472, 4258.382534532491, 4261.190373828978, 4320.740755554677, 4267.679924005696, 4287.5498072702385, 4325.134973005412, 4326.156399502099, 4377.037051848588, 4115.506139263278, 4263.275243208631, 4278.0, 4296.0, 4372.693911426201, 4142.751434913885, 4201.558836322203, 4213.6839737019845, 4258.659307255412, 4260.786960651955, 4223.303154979425, 4224.049588842486, 4227.133437645275, 4278.443802305712, 4281.807318670667, 4600.9769951150365, 4613.677042607019, 4628.32889231063, 4634.559716826896, 4681.391419115494, 4736.692115012514, 4795.712257264575, 4890.315355850184, 4922.335484709554, 4957.677750946177, 4938.08645400602, 4949.604031677457, 4952.059108769322, 4974.825881094144, 5007.198848184309, 4600.194965880957, 4604.884877878013, 4607.608353289975, 4610.426840117852, 4653.976730116362, 4779.4742578317055, 4872.805087796449, 4912.508749125131, 5048.545630893163, 5106.795728170906, 4761.642876784185, 4763.356946812205, 4766.618670506351, 4814.301926220678, 4822.42130944289, 4798.376211092535, 4799.3041009053495, 4804.231322988305, 4807.78364973577, 4857.198562237262, 4665.0, 4706.058788242365, 4788.257820037899, 4788.569028787426, 4854.101991131652, 4810.855674329776, 4824.228123500223, 4856.490068542823, 4891.877703057381, 4939.3084968104495, 4199.2441360555395, 4203.222403855236, 4208.537060923296, 4211.852585159505, 4254.7021708480725, 3649.3248748981523, 3715.4241092630687, 3735.1782607826235, 3738.9439158412647, 3756.6055564165367, 4196.979015104905, 4200.537940826506, 4243.236217480821, 4275.957240427556, 4307.267764480046, 5001.624878134082, 5045.495450454925, 5046.0, 5053.343065401547, 5053.67151135175, 4317.56824317572, 4323.373110898902, 4326.63223625989, 4370.7159034662645, 4375.081232941055, 4525.637948964075, 4533.705309154894, 4534.274516077412, 4534.387857639176, 4594.609458196091, 4517.728936263835, 4554.635629149594, 4620.145273124483, 4658.557437043475, 4715.0473549551725, 4872.853814385574, 4877.195262781744, 4894.290327902363, 4917.237828136645, 4932.45742968266, 4653.0, 4653.53464653532, 4655.348251244761, 4703.294505824154, 4714.198586240279, 4627.514111018295, 4721.102990431807, 4815.975920120517, 4817.542333478314, 4819.445763737215, 4888.144574699342, 4910.975445122752, 4935.432425271139, 4997.550220480174, 4998.375203099613, 4733.763311834326, 4740.9051818962735, 4754.215554433618, 4772.856814295576, 4781.13939490895, 4574.725516469022, 4642.257238841769, 4727.1963766160525, 4739.218029025173, 4808.447028591617, 4600.539946005372, 4687.789049492712, 4694.929576056294, 4699.647526435463, 4743.525647435229, 4777.0684716479955, 4783.928241076317, 4784.091022705675, 4784.617230621611, 4848.3454733611925, 4549.68152229354, 4673.205555055717, 4677.508861569486, 4686.0, 4736.5973892219545], "value": 4514.831490151944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4892596663003, 571.7884382778371, 577.7400169923535, 578.1905332534449, 583.9605502206072, 27637.17088487346, 39080.80459597702, 40118.19763604726, 40298.79850600743, 43382.349264760975, 40980.79509602455, 41111.79444102783, 41179.17641647165, 41216.0, 41226.381604275884, 7241.6379181041, 7715.768526944201, 7899.565523896184, 7903.0516338039515, 7905.525668459911, 7254.891176632328, 9633.325667203264, 9878.160356369717, 9882.456464894429, 10236.0, 9883.357581757198, 9938.602455901755, 9939.155171810406, 9944.85082723756, 9946.353487023356, 9844.556994935208, 9897.703068907873, 9906.108450239513, 9926.45404502752, 9928.950355248213, 9697.709068727949, 9765.0, 9767.218622510181, 9770.413775173442, 9770.853437198448, 38226.80886595577, 38238.235235295135, 38292.425613615815, 38299.0, 38376.61623383759, 2793.427347393779, 2813.535766598509, 2828.5050116229577, 3081.260497480611, 3180.3957248122783, 27419.725802741916, 28533.144005679864, 28571.28571785722, 29092.418151636848, 30190.396192076256, 3471.357798807229, 3473.8263086845554, 3502.6672466115933, 3627.0569651890432, 3651.415773476231, 247693.76153119298, 249500.0, 249624.0, 249832.0, 250043.0, 28127.578086328722, 28999.84000639993, 52037.2194417084, 52325.47674523206, 52426.21360679593, 31807.0, 31835.363292734015, 31978.360432791214, 32018.19954501156, 32022.67977320197, 13017.609471715863, 13186.868131318755, 13192.538261160813, 13206.471741130246, 13213.14114582549, 8612.698555550525, 8827.426217295855, 10684.626038088785, 10711.410872401937, 10762.24664273509, 7558.2441755823975, 7668.923310766932, 7744.961275193588, 7754.806129846799, 7761.301482866569, 3054.3433161870303, 3084.7327214497327, 3092.505199168122, 3107.0678796361003, 3128.0615815255787, 777.1063277231117, 790.083503136359, 809.663989444374, 881.8809460722848, 900.8468560344758, 23379.766202338098, 25180.748192518207, 25317.74682253154, 25520.23439296824, 25680.229593112235, 950.1306304731094, 955.2787645327733, 962.5379817687549, 1038.8130136575337, 1046.2885238038207, 13422.328883555783, 14166.929165354313, 14339.713205735827, 14342.569722908329, 14401.927990360191, 121304.0, 594940.0, 612989.0, 613911.0, 617329.0, 49089.50910490921, 49611.503884961414, 49756.253656195186, 49865.25202121971, 49896.750516247186, 1029.9227557933184, 1051.794899994509, 1113.8886111388797, 1186.9643910682694, 1199.8380218670543, 24747.381315467257, 28657.28356791097, 28772.280692982844, 29329.706702932697, 29532.261693457836, 40450.0, 40917.0, 41175.0, 41188.58811411967, 41215.175696486505, 244274.0, 244996.0, 245258.0, 245268.0, 246302.0, 24243.272701818973, 25023.249302520955, 25333.493330132926, 25385.238442846745, 26577.0, 35182.54909060175, 35349.469757953135, 35403.29193416169, 36075.0, 36370.8181459091, 34151.146221344665, 34364.31271374509, 34503.654963451045, 34679.826600866836, 35451.645483545864, 34654.306913862085, 34862.0, 35016.0, 35188.64811351854, 35555.466667999484, 33850.49224261687, 34244.315113697085, 34605.30789384249, 34731.82634086813, 35113.0, 26790.866045669645, 31624.367512649158, 32626.673733262363, 33221.33557328791, 35713.10717231986, 22753.0, 22886.885565572065, 22923.88538057299, 23124.0, 23172.768272317062], "value": 16362.910919548869, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7222041815503, 347.7791602332518, 361.7449697962936, 367.19584110797354, 385.4738282244735, 12304.507819687213, 13329.200247985116, 15552.066875987448, 16541.503754887373, 17781.55546111348, 16862.494125176232, 17007.23467443965, 17063.658726825455, 17159.227834747435, 17181.7422738659, 4066.329055705805, 4923.655344125904, 5123.871903202413, 5127.897442051157, 5191.247269145972, 4976.328195693589, 5092.28707980883, 5093.770780314876, 5097.566706829905, 5106.744662766865, 4841.426536375692, 5001.8249361272365, 5072.492750724935, 5078.21287700407, 5079.898402031957, 5036.82371117011, 5076.23856421536, 5080.314157588715, 5085.974570127163, 5088.084144853925, 4430.933535996963, 4455.04216593434, 4549.09018196362, 4551.658625603093, 4553.635709143294, 20201.79798202014, 20376.592468150553, 20445.795542044685, 20534.69197962032, 20545.794542054537, 1782.7147656374918, 1797.0565453137076, 1800.342874850683, 1895.7819850717206, 2493.2021753039035, 12626.747465050648, 12870.678233044155, 13077.673058173526, 13629.318534073256, 13764.587062388144, 1673.046363572764, 1714.6742118997352, 1716.0, 1736.8436840684399, 1756.3325936144183, 67548.3245167547, 67874.0, 68167.31832681708, 68195.65902170457, 69055.65472172658, 8990.325725570608, 9221.492817894947, 9710.17463515595, 9743.805123897624, 9765.365251258645, 13022.218666880017, 13034.0, 13047.282399467931, 13047.478100875858, 13050.934745326213, 6724.394804467622, 6883.449324054063, 6965.895511567229, 7080.256573059857, 7174.174969878531, 6466.579672321378, 6518.804435866931, 6658.500612454085, 6705.832354191184, 6784.118064651564, 5786.334571524244, 5888.205092312569, 5952.166696662471, 6042.0969804268025, 6060.545459090586, 1521.5815650696147, 1661.2607389711704, 1746.7467217253427, 1762.4272111563794, 1793.2737241417246, 673.9224989126313, 744.9180590135081, 819.573821612758, 861.0184389795638, 921.0881227584777, 16591.25339359732, 16896.32414703398, 17467.47597572075, 17721.0, 18054.819451805313, 799.868021776412, 844.1937949258444, 855.7304449098514, 864.7492227254025, 874.5277550122862, 9435.716928492018, 10198.0, 10223.795524089477, 10226.130778883879, 10308.433036182932, 377546.0, 382321.0, 383889.0, 385861.2017978447, 390244.0, 69272.6536367315, 69482.30517694859, 70602.64698676474, 70693.64653176804, 70991.2900870995, 880.6521424037597, 899.4738078224182, 903.4940433357209, 916.7478943290648, 923.930705197113, 14622.317382860787, 15064.162909379267, 15801.525954221392, 15901.681966360376, 16062.598435039217, 29247.561286580294, 34673.0, 35598.28803423969, 35667.92996210118, 36027.0, 45522.0, 45986.54013459956, 46619.30071048869, 46658.53341466542, 46780.29829552492, 7190.1371835377995, 7238.6018768968215, 7362.705491780269, 7396.778096657109, 7649.502782319131, 11085.889141108486, 11324.207305488537, 11676.357800321064, 11850.703732406759, 12103.487064116985, 10164.542595583365, 10242.692719218436, 10336.793264134525, 10548.208884333551, 10677.839832402675, 9874.605015799287, 10108.94945525297, 10285.0, 10304.072633463024, 10642.787144257227, 10138.138258248131, 10265.12746416563, 10727.356358618508, 10743.677689669323, 10787.406692631981, 7235.421166306577, 7463.253674632493, 7726.806829829299, 7817.765467035998, 8076.757697269091, 10002.399856008662, 10170.389776613427, 10225.642102526375, 10426.582936682751, 10837.837432438362], "value": 8101.697270793007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.268155196194, 1383.4950243161245, 1426.6789972256245, 1653.2642973876623, 1655.4371513685344, 6598.769043083493, 6838.179418469791, 7203.747868824586, 7743.18696536864, 7778.9222107778905, 7013.0, 7281.271872812716, 7283.562986220817, 7475.588842613654, 7481.513701609405, 2116.2487317002474, 2124.2565102214257, 2135.29535253366, 2140.218820130649, 2142.6143294207036, 1805.4493379519242, 1862.5064357945155, 2083.5728675621535, 2121.8939053047284, 2153.5154590217235, 2050.548879246571, 2102.348272035666, 2120.756113047004, 2132.2856842957626, 2142.4965133193764, 2103.295396042328, 2120.766715661284, 2130.8401869859745, 2153.246363772667, 2155.1810312081466, 2013.224908410258, 2013.9798602013939, 2015.3147929703825, 2015.7177995080701, 2017.4754563813367, 7362.153352364439, 7424.109106907152, 7437.702491900318, 7444.627768611548, 7587.241275872424, 4312.504062032844, 4335.848245311399, 4410.448693913261, 4465.933011004838, 4492.528284530143, 2847.345110624568, 2910.854457277149, 2960.304328482805, 2965.184574242079, 2968.0, 921.7833809054866, 927.420362273579, 943.2783920300975, 948.170350942925, 954.7613096725819, 10225.079742823107, 10231.437270950095, 10273.640422585173, 10277.075063244343, 10279.845802312897, 3978.0, 4096.56986016464, 4171.457710497616, 4188.246115699142, 4199.370094485852, 7949.403794715419, 8074.152214017561, 8090.393220508486, 8101.351891848638, 8109.75670729879, 4365.06151177492, 4373.978130109329, 4376.168527979674, 4377.78111094444, 4386.122775444924, 4029.3955906613655, 4069.1251380953236, 4072.3484242521645, 4074.30736774749, 4077.368007958771, 3129.6713845045942, 3203.4554125798672, 3225.854836532362, 3243.8864639737494, 3248.1554795753273, 906.6600024990629, 935.1817159985013, 951.8239125761756, 973.5910917414703, 986.9457179855033, 757.8938948547208, 767.0680123649793, 808.3210103513077, 830.9626066827008, 863.5207459859838, 5235.319408476874, 5290.894182116336, 5361.463853614608, 5406.135018397116, 5603.327600687943, 416.4315709057115, 443.1071391146842, 445.3320019970045, 447.21960179487, 599.1127946967089, 3517.577890653138, 3543.309054734302, 3631.092226943264, 3649.708023358125, 3674.2651469706166, 8755.737327880173, 9160.954195229115, 9175.954120229357, 9176.6788162414, 9181.357304988587, 9124.817503650023, 9125.45247285165, 9127.041660625671, 9128.543572821332, 9139.451632902048, 6596.967015164893, 6789.0834737310815, 6897.758578449831, 6920.826979325557, 6989.685464154125, 5185.403678577012, 5193.792248310026, 5295.523402893604, 5304.336957880265, 5364.14173732201, 8693.695720649746, 8779.297656187617, 8787.956060219658, 8792.956035219782, 8876.068012858816, 8673.479591224546, 8806.251468625238, 8838.734837954871, 8880.067592902911, 8891.244244239311, 6578.276389597237, 6617.371349721769, 6666.200055993312, 6719.664016799238, 6748.223954245324, 7122.964385178041, 7222.422206223595, 7225.349718525358, 7235.457340699574, 7237.927620723725, 6234.189555357956, 6324.083007963727, 6325.936740632719, 6341.873162536631, 6376.043593461018, 6303.401176888188, 6306.653134077486, 6355.682215889279, 6402.423781859655, 6435.581687190318, 6029.397060293935, 6198.380161983766, 6199.504039676905, 6213.813585592439, 6219.626822390671, 4607.953920460753, 4619.607333376701, 4621.0, 4699.553542413602, 4731.810727570996, 4520.954790452053, 4527.547245275446, 4600.42494688164, 4651.372064771348, 4795.928061079157], "value": 3918.176533016481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6396068874596, 292.90334189717396, 295.44308977577265, 300.57018463597046, 304.4307145637655, 4825.734584597846, 4862.34358361622, 4876.0, 4880.341153944217, 4885.267209918514, 4768.117898188829, 4799.664023518355, 4817.927731084036, 4856.97571512142, 4868.440129385113, 3571.8928432147077, 3679.797611131387, 3688.79711615861, 3696.3346597612554, 3701.2425742821633, 3591.2099338145567, 3679.319325924699, 3695.870644527442, 3726.217494326195, 3753.0617345663586, 3690.874283343579, 3708.1841994761107, 3712.535933008374, 3720.107174278181, 3725.143217060078, 3617.2042150726797, 3709.2766910452474, 3712.3317802795486, 3727.5154229949935, 3738.12154143776, 3294.934101317984, 3302.339532093591, 3303.5705358303267, 3309.0, 3313.1551454378978, 4639.350490931272, 4654.394928659286, 4662.440507139131, 4702.764861756898, 4718.622510199176, 4310.374995625617, 4318.719283246579, 4324.675649326313, 4329.9134017319475, 4331.956680433187, 4788.138135135674, 5021.824236151717, 5039.571636410909, 5054.292399064134, 5056.469070747592, 3554.5201397811484, 3555.093451169961, 3556.0931962349696, 3557.8221088945706, 3560.12776869666, 5224.764885580158, 5236.921446178349, 5263.578913686896, 5289.656172348824, 5290.153575427951, 3524.277523107808, 3616.4936908832783, 3630.2739452109686, 3639.3813051781262, 3645.5989841117457, 3664.4136938089778, 3664.670179683788, 3670.9816450917574, 3677.3196958562753, 3704.944425833615, 4221.97889010553, 4226.556211597799, 4232.809523571446, 4238.682098842599, 4262.914741705148, 4993.704155257586, 5009.296839074659, 5018.2974383586325, 5020.472850350734, 5026.798928042837, 1198.4846515998204, 1257.3838818978634, 1262.7348256865978, 1265.1460264321547, 1265.2155663488695, 779.4115442840618, 779.9103103143098, 811.4644334739162, 817.37062461904, 823.1603764160523, 3977.960220397817, 4277.251480990814, 4404.427424434867, 4414.227510185705, 4538.750368729686, 5116.948830511722, 5146.253793199965, 5166.095933211673, 5225.973870130625, 5230.476952304739, 4453.242948698729, 4470.719932834278, 4472.396226509444, 4483.977580112079, 4514.345419914094, 2646.563317052665, 2726.6864310604137, 2730.6313647657707, 2762.654668166479, 2763.5301998660275, 4919.458859525449, 4922.458529561745, 4928.753562321869, 4947.282644016597, 4948.529889660476, 5241.73791310433, 5258.553022993012, 5278.234655974862, 5282.31329927107, 5302.893942121136, 4689.3903792507435, 4878.170710979142, 4911.926321105187, 4923.8921242721535, 4976.825811096594, 5139.434662187082, 5143.871403214949, 5170.948290517047, 5187.922181167361, 5194.662346947436, 4923.753812309298, 5080.8221712241375, 5082.796688132581, 5093.337866077386, 5105.693658380361, 4873.46391896884, 4913.459519452929, 4915.26271059344, 4927.334809800631, 4938.148244369398, 3573.6426357364057, 3575.8927232183078, 3578.0, 3581.1942312980414, 3583.1009564930628, 5138.537531622172, 5165.380154381498, 5168.147255702767, 5181.792728290826, 5197.506236907488, 4782.426108866958, 5000.199888062696, 5004.049230646166, 5014.57376123019, 5026.447090819934, 4989.875253118701, 5014.395393474053, 5015.473375295542, 5024.799008039638, 5034.2951986721155, 4940.814204590944, 4954.479779623088, 4959.975200123977, 4965.97517012427, 4986.775595098156, 4839.540243676845, 4857.854264372075, 4992.400911890451, 5065.696058236517, 5095.541401273903, 4800.399950006249, 4890.975545122252, 4968.155413579772, 4971.627127965489, 4981.825636102864], "value": 3771.8906865161885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2527476368576, 592.7391947543081, 658.0096954084103, 665.5407768639635, 697.7488104282454, 11344.943275283622, 12572.497100116007, 12626.30555319457, 12631.936840315808, 12660.556880509184, 11428.599999000036, 11503.712407189803, 11513.194076414655, 11513.942430287836, 11545.134114941391, 589.9557533185007, 609.2810483629315, 724.6557885004607, 728.0317178153057, 753.1790348520112, 747.2938073520526, 751.29003092078, 759.5518644000039, 760.2853317881202, 760.52467207995, 632.1529150937743, 803.6664784114586, 805.2068712318362, 805.3235282362814, 805.7059173401695, 640.3756337570878, 771.1247733822124, 779.6413649721135, 787.7557957033338, 798.1659166171307, 585.066818424612, 586.0242695911345, 586.4809643465521, 586.6568057686259, 586.6656006076538, 11113.888861111367, 11162.274452160584, 11203.607873724462, 11338.149638777124, 11713.941430292794, 12179.451924663323, 12469.501219951191, 12673.683157921034, 12790.936045319806, 13190.406431710597, 9356.625734970594, 9468.621255149787, 9649.228061755042, 9978.800423991552, 10460.895391046068, 3851.287511810324, 3860.1893602343544, 3961.702872284561, 3968.6981550700525, 3972.960270397317, 52463.47536524624, 54091.72954135204, 54788.0, 59127.40872591262, 60437.0, 10333.431661258703, 10422.426766527913, 10599.205059620559, 10695.625653102104, 10984.395858227714, 19573.60852782965, 19585.804141958684, 19591.510212244808, 19600.901995490218, 19602.803971960384, 6952.443804495628, 6956.8956465653055, 7166.53417527859, 7314.597697126603, 7325.450591205575, 3452.4476083826466, 3537.2041290709385, 3543.3799085159994, 3565.5721313442555, 3695.2055308108347, 2805.5511118221393, 2911.301287690981, 2912.985435072811, 2923.473774720571, 2924.8391338476163, 489.2338657446615, 494.1007366592838, 502.32939026400163, 504.60388594952786, 508.217345288252, 527.3961314295111, 538.0610834094452, 574.8074395077613, 590.4951266666937, 609.3206075226091, 6597.80206593803, 6722.327767223239, 7033.964830175816, 7035.904202151037, 8050.56950325005, 565.5786439102894, 568.4679787971378, 580.160682728338, 587.3157771196594, 592.1916583863082, 3788.3559794834946, 3893.980530097331, 3955.7033222508426, 3983.063979964706, 4092.07928216149, 57599.0, 58377.124343134885, 95966.52016739872, 104304.0, 108111.48606424197, 88780.0, 88845.11154888498, 89182.0, 89626.55186724155, 90763.54618226999, 45038.54961450409, 46138.769306153925, 46261.768691157675, 58799.0, 74766.25233747593, 7155.0, 7280.765515936573, 7363.558186508827, 7586.165521792709, 7617.619119044137, 31270.374592507567, 31912.202194945312, 33443.498347525296, 40388.79805600953, 43143.13713725645, 59260.70369648124, 61343.38656613555, 68437.65781171063, 70985.0, 71131.0, 9559.569819358006, 9695.66065187715, 9777.657781977881, 9870.161036311707, 10054.64808731691, 9275.07249275067, 9554.761130971781, 10496.68509944703, 10579.576816927236, 10798.622048228588, 9644.614215431304, 9817.803643926938, 10040.748981275527, 10144.898551014396, 10164.085232329126, 10125.64560240388, 10235.539400726837, 10373.377597343882, 10387.324823886423, 10417.322874013165, 9953.402795832273, 9986.35088719231, 10186.796264074528, 10249.33379330341, 10718.410487423267, 8393.916060839314, 8738.868916966123, 8782.868256976279, 8783.824323513621, 9013.143751343612, 8389.580520973805, 8424.705135320235, 8590.14098590136, 8614.18165274298, 8775.297976162019], "value": 6109.143784838797, "unit": "score"}], "name": "dromaeo_css", "value": 6148.821177992113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 115.0, 117.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 124.0, 167.0, 125.0, 126.0, 125.0, 125.0, 168.0, 130.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 102.0, 78.0, 76.0, 77.0, 75.0, 108.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 85.0, 85.0, 83.0, 121.0, 84.0, 84.0, 126.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 84.0, 83.0, 84.0, 83.0, 84.0, 83.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 137.0, 134.0, 141.0, 132.0, 134.0, 131.0, 180.0, 131.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 172.0, 175.0, 176.0, 177.0, 180.0, 176.0, 173.0, 179.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 74.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 69.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1551.6999999999998, "alertThreshold": 2.0}]} 06:27:50 INFO - Return code: 0 06:27:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:27:50 INFO - # TBPL SUCCESS # 06:27:50 INFO - Running post-action listener: _resource_record_post_action 06:27:50 INFO - [mozharness: 2016-09-22 13:27:50.529512Z] Finished run-tests step (success) 06:27:50 INFO - Running post-run listener: _resource_record_post_run 06:27:50 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 403443712; Read time: 0; Write time: 243808 06:27:50 INFO - TinderboxPrint: CPU usage
13.0% 06:27:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:27:50 INFO - TinderboxPrint: I/O write bytes / time
403,443,712 / 243,808 06:27:50 INFO - TinderboxPrint: CPU idle
8,334.5 (87.0%) 06:27:50 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 06:27:50 INFO - TinderboxPrint: Swap in / out
0 / 0 06:27:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99893248; Read time: 0; Write time: 81692 06:27:50 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292200448; Read time: 0; Write time: 159952 06:27:51 INFO - Running post-run listener: _upload_blobber_files 06:27:51 INFO - Blob upload gear active. 06:27:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:27:51 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 06:27:51 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:27:51 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:27:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:52 INFO - (blobuploader) - INFO - Done attempting. 06:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:55 INFO - (blobuploader) - INFO - Done attempting. 06:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:56 INFO - (blobuploader) - INFO - Done attempting. 06:27:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:27:56 INFO - Return code: 0 06:27:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:27:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:27:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9942126e533a83ee731574322b780c46e3325bc5a43047baa77390e86ac731a4f6122f9ccbaf78be49f9e3f1e5068e872d2f1f17e69ae3a150224edb8cc08ff1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2645df6cf655151b8704ea38aa18f79835b265b4ac329df2bdf5e3738f846708b695a4958b000a9960914f8735dfe92f44bb66c4622b3412453179b0f9b574bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52a423580e8f31c56bc83df403dac3a87a6780305f2740bf23eff02f5315613225d978f3cdecbcf2302fb155fa01ce0835bd87fbefe5abbce0f010793192791b"} 06:27:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:27:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:27:56 INFO - Contents: 06:27:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9942126e533a83ee731574322b780c46e3325bc5a43047baa77390e86ac731a4f6122f9ccbaf78be49f9e3f1e5068e872d2f1f17e69ae3a150224edb8cc08ff1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2645df6cf655151b8704ea38aa18f79835b265b4ac329df2bdf5e3738f846708b695a4958b000a9960914f8735dfe92f44bb66c4622b3412453179b0f9b574bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52a423580e8f31c56bc83df403dac3a87a6780305f2740bf23eff02f5315613225d978f3cdecbcf2302fb155fa01ce0835bd87fbefe5abbce0f010793192791b"} 06:27:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:27:56 INFO - Copying logs to upload dir... 06:27:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:27:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.543670 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-22 06:27:55.840467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 06:27:55.844237) ========= 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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9942126e533a83ee731574322b780c46e3325bc5a43047baa77390e86ac731a4f6122f9ccbaf78be49f9e3f1e5068e872d2f1f17e69ae3a150224edb8cc08ff1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2645df6cf655151b8704ea38aa18f79835b265b4ac329df2bdf5e3738f846708b695a4958b000a9960914f8735dfe92f44bb66c4622b3412453179b0f9b574bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52a423580e8f31c56bc83df403dac3a87a6780305f2740bf23eff02f5315613225d978f3cdecbcf2302fb155fa01ce0835bd87fbefe5abbce0f010793192791b"} build_url:https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011544 build_url: 'https://queue.taskcluster.net/v1/task/YHJ7abeaQOCLLkVMDN8oGw/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/Autoland-Non-PGO/sha512/9942126e533a83ee731574322b780c46e3325bc5a43047baa77390e86ac731a4f6122f9ccbaf78be49f9e3f1e5068e872d2f1f17e69ae3a150224edb8cc08ff1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2645df6cf655151b8704ea38aa18f79835b265b4ac329df2bdf5e3738f846708b695a4958b000a9960914f8735dfe92f44bb66c4622b3412453179b0f9b574bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52a423580e8f31c56bc83df403dac3a87a6780305f2740bf23eff02f5315613225d978f3cdecbcf2302fb155fa01ce0835bd87fbefe5abbce0f010793192791b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 06:27:55.874561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:27:55.874960) ========= 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=6dbc10da6d83fee962c624be000001a8-1474548836.543393-1412574126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 06:27:55.960840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 06:27:55.961284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 06:27:55.961616) ========= ========= Total master_lag: 0.17 =========