builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1474897011.47 results: success (0) buildid: 20160926041252 builduid: 557bab29aaeb4c3b9de51a813111fc0c revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.474371) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.474770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.475083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.514990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.515349) ========= 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=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 06:36:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2016-09-26 06:36:51 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.633380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.636742) ========= 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=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:51.686332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 06:36:51.689691) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 06:36:51,855 truncating revision to first 12 chars 2016-09-26 06:36:51,855 Setting DEBUG logging. 2016-09-26 06:36:51,855 attempt 1/10 2016-09-26 06:36:51,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 06:36:53,101 unpacking tar archive at: fx-team-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.585096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 06:36:53.288506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:53.288834) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:53.289203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:53.289459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 06:36:53.299253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-26 06:36:53.299517) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:53 INFO - MultiFileLogger online at 20160926 06:36:53 in /builds/slave/test 06:36:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:36:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:53 INFO - {'append_to_log': False, 06:36:53 INFO - 'base_work_dir': '/builds/slave/test', 06:36:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:36:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:53 INFO - 'branch': 'Fx-Team-Non-PGO', 06:36:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:53 INFO - 'config_files': ('talos/linux_config.py',), 06:36:53 INFO - 'default_actions': ('clobber', 06:36:53 INFO - 'read-buildbot-config', 06:36:53 INFO - 'download-and-extract', 06:36:53 INFO - 'populate-webroot', 06:36:53 INFO - 'create-virtualenv', 06:36:53 INFO - 'install', 06:36:53 INFO - 'run-tests'), 06:36:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:53 INFO - 'download_minidump_stackwalk': True, 06:36:53 INFO - 'download_symbols': 'ondemand', 06:36:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:53 INFO - 'installer_path': 'installer.exe', 06:36:53 INFO - 'log_level': 'info', 06:36:53 INFO - 'log_name': 'talos', 06:36:53 INFO - 'log_to_console': True, 06:36:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:53 INFO - 'opt_config_files': (), 06:36:53 INFO - 'pip_index': False, 06:36:53 INFO - 'sps_profile': False, 06:36:53 INFO - 'sps_profile_interval': 0, 06:36:53 INFO - 'suite': 'dromaeojs', 06:36:53 INFO - 'system_bits': '32', 06:36:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:53 INFO - 'title': 'talos-linux64-ix-032', 06:36:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:53 INFO - 'use_talos_json': True, 06:36:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:53 INFO - 'work_dir': 'build'} 06:36:53 INFO - [mozharness: 2016-09-26 13:36:53.564559Z] Running clobber step. 06:36:53 INFO - Running pre-action listener: _resource_record_pre_action 06:36:53 INFO - Running main action method: clobber 06:36:53 INFO - rmtree: /builds/slave/test/build 06:36:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:54 INFO - Running post-action listener: _resource_record_post_action 06:36:54 INFO - [mozharness: 2016-09-26 13:36:54.013301Z] Finished clobber step (success) 06:36:54 INFO - [mozharness: 2016-09-26 13:36:54.013412Z] Running read-buildbot-config step. 06:36:54 INFO - Running pre-action listener: _resource_record_pre_action 06:36:54 INFO - Running main action method: read_buildbot_config 06:36:54 INFO - Using buildbot properties: 06:36:54 INFO - { 06:36:54 INFO - "project": "", 06:36:54 INFO - "product": "firefox", 06:36:54 INFO - "script_repo_revision": "production", 06:36:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:36:54 INFO - "repository": "", 06:36:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:36:54 INFO - "buildid": "20160926041252", 06:36:54 INFO - "pgo_build": "False", 06:36:54 INFO - "basedir": "/builds/slave/test", 06:36:54 INFO - "buildnumber": 3351, 06:36:54 INFO - "slavename": "talos-linux64-ix-032", 06:36:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:36:54 INFO - "platform": "ubuntu64_hw", 06:36:54 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 06:36:54 INFO - "branch": "fx-team", 06:36:54 INFO - "repo_path": "integration/fx-team", 06:36:54 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 06:36:54 INFO - "stage_platform": "linux64", 06:36:54 INFO - "builduid": "557bab29aaeb4c3b9de51a813111fc0c", 06:36:54 INFO - "slavebuilddir": "test" 06:36:54 INFO - } 06:36:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:36:54 INFO - Running post-action listener: _resource_record_post_action 06:36:54 INFO - [mozharness: 2016-09-26 13:36:54.015914Z] Finished read-buildbot-config step (success) 06:36:54 INFO - [mozharness: 2016-09-26 13:36:54.016004Z] Running download-and-extract step. 06:36:54 INFO - Running pre-action listener: _resource_record_pre_action 06:36:54 INFO - Running main action method: download_and_extract 06:36:54 INFO - mkdir: /builds/slave/test/build/tests 06:36:54 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:36:54 INFO - trying https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:54 INFO - Downloading https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/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:36:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/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:36:54 INFO - Downloaded 1361 bytes. 06:36:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:54 INFO - Using the following test package requirements: 06:36:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:36:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'jsshell-linux-x86_64.zip'], 06:36:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:36:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:36:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:54 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:55 INFO - Expected file size: 20410618 06:36:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:36:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:37:00 INFO - Expected file size: 20410618 06:37:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:37:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:37:05 INFO - Expected file size: 14414057 06:37:06 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:37:06 INFO - trying https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/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:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/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:37:08 INFO - Downloaded 55743729 bytes. 06:37:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:08 INFO - mkdir: /builds/slave/test/properties 06:37:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:08 INFO - Contents: 06:37:08 INFO - build_url:https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:37:09 INFO - Running post-action listener: _resource_record_post_action 06:37:09 INFO - Running post-action listener: set_extra_try_arguments 06:37:09 INFO - [mozharness: 2016-09-26 13:37:09.680692Z] Finished download-and-extract step (success) 06:37:09 INFO - [mozharness: 2016-09-26 13:37:09.680917Z] Running populate-webroot step. 06:37:09 INFO - Running pre-action listener: _resource_record_pre_action 06:37:09 INFO - Running main action method: populate_webroot 06:37:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:09 INFO - '--tppagecycles', 06:37:09 INFO - '7'], 06:37:09 INFO - 'tests': ['tsvgm']}}, 06:37:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['damp', 'tps']}, 06:37:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'tests': ['damp', 'tps']}, 06:37:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['dromaeo_dom']}, 06:37:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['basic_compositor_video']}, 06:37:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:37:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['a11yr', 06:37:09 INFO - 'ts_paint', 06:37:09 INFO - 'tpaint', 06:37:09 INFO - 'sessionrestore', 06:37:09 INFO - 'sessionrestore_no_auto_restore', 06:37:09 INFO - 'tabpaint']}, 06:37:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['tsvgx', 06:37:09 INFO - 'tsvgr_opacity', 06:37:09 INFO - 'tart', 06:37:09 INFO - 'tscrollx', 06:37:09 INFO - 'cart']}, 06:37:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:09 INFO - 'tsvgr_opacity', 06:37:09 INFO - 'tart', 06:37:09 INFO - 'tscrollx', 06:37:09 INFO - 'cart']}, 06:37:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'talos_options': ['--disable-e10s'], 06:37:09 INFO - 'tests': ['tp5o']}, 06:37:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'tests': ['tp5o']}, 06:37:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'talos_options': ['--disable-e10s', 06:37:09 INFO - '--xperf_path', 06:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:09 INFO - 'tests': ['tp5n']}, 06:37:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:09 INFO - 'talos_options': ['--xperf_path', 06:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:09 INFO - 'tests': ['tp5n']}}, 06:37:09 INFO - 'talos.zip': {'path': '', 06:37:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:09 INFO - Running post-action listener: _resource_record_post_action 06:37:09 INFO - [mozharness: 2016-09-26 13:37:09.699694Z] Finished populate-webroot step (success) 06:37:09 INFO - [mozharness: 2016-09-26 13:37:09.699782Z] Running create-virtualenv step. 06:37:09 INFO - Running pre-action listener: _resource_record_pre_action 06:37:09 INFO - Running main action method: create_virtualenv 06:37:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:37:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:09 INFO - Using real prefix '/usr' 06:37:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:12 INFO - Installing pip.................done. 06:37:12 INFO - Return code: 0 06:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:37:12 INFO - Reading from file tmpfile_stdout 06:37:12 INFO - Output received: 06:37:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:37:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:37:12 INFO - Using env: {'DISPLAY': ':0', 06:37:12 INFO - 'HOME': '/home/cltbld', 06:37:12 INFO - 'LANG': 'en_US.UTF-8', 06:37:12 INFO - 'LANGUAGE': 'en_US:en', 06:37:12 INFO - 'LOGNAME': 'cltbld', 06:37:12 INFO - 'MAIL': '/var/mail/cltbld', 06:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:12 INFO - 'MOZ_NO_REMOTE': '1', 06:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:12 INFO - 'NO_EM_RESTART': '1', 06:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:12 INFO - 'PWD': '/builds/slave/test', 06:37:12 INFO - 'SHELL': '/bin/bash', 06:37:12 INFO - 'SHLVL': '1', 06:37:12 INFO - 'TERM': 'linux', 06:37:12 INFO - 'TMOUT': '86400', 06:37:12 INFO - 'USER': 'cltbld', 06:37:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:12 INFO - '_': '/tools/buildbot/bin/python'} 06:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:37:12 INFO - Cleaning up... 06:37:12 INFO - Return code: 0 06:37:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:37:12 INFO - Using env: {'DISPLAY': ':0', 06:37:12 INFO - 'HOME': '/home/cltbld', 06:37:12 INFO - 'LANG': 'en_US.UTF-8', 06:37:12 INFO - 'LANGUAGE': 'en_US:en', 06:37:12 INFO - 'LOGNAME': 'cltbld', 06:37:12 INFO - 'MAIL': '/var/mail/cltbld', 06:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:12 INFO - 'MOZ_NO_REMOTE': '1', 06:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:12 INFO - 'NO_EM_RESTART': '1', 06:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:12 INFO - 'PWD': '/builds/slave/test', 06:37:12 INFO - 'SHELL': '/bin/bash', 06:37:12 INFO - 'SHLVL': '1', 06:37:12 INFO - 'TERM': 'linux', 06:37:12 INFO - 'TMOUT': '86400', 06:37:12 INFO - 'USER': 'cltbld', 06:37:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:12 INFO - '_': '/tools/buildbot/bin/python'} 06:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:12 INFO - Downloading/unpacking psutil>=3.1.1 06:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:14 INFO - Installing collected packages: psutil 06:37:14 INFO - Running setup.py install for psutil 06:37:14 INFO - building 'psutil._psutil_linux' extension 06:37:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:37:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:37:15 INFO - building 'psutil._psutil_posix' extension 06:37:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:37:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:37:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:15 INFO - Successfully installed psutil 06:37:15 INFO - Cleaning up... 06:37:15 INFO - Return code: 0 06:37:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:37:15 INFO - Using env: {'DISPLAY': ':0', 06:37:15 INFO - 'HOME': '/home/cltbld', 06:37:15 INFO - 'LANG': 'en_US.UTF-8', 06:37:15 INFO - 'LANGUAGE': 'en_US:en', 06:37:15 INFO - 'LOGNAME': 'cltbld', 06:37:15 INFO - 'MAIL': '/var/mail/cltbld', 06:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:15 INFO - 'MOZ_NO_REMOTE': '1', 06:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:15 INFO - 'NO_EM_RESTART': '1', 06:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:15 INFO - 'PWD': '/builds/slave/test', 06:37:15 INFO - 'SHELL': '/bin/bash', 06:37:15 INFO - 'SHLVL': '1', 06:37:15 INFO - 'TERM': 'linux', 06:37:15 INFO - 'TMOUT': '86400', 06:37:15 INFO - 'USER': 'cltbld', 06:37:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:15 INFO - '_': '/tools/buildbot/bin/python'} 06:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:37:17 INFO - Installing collected packages: mozsystemmonitor 06:37:17 INFO - Running setup.py install for mozsystemmonitor 06:37:17 INFO - Successfully installed mozsystemmonitor 06:37:17 INFO - Cleaning up... 06:37:17 INFO - Return code: 0 06:37:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:37:17 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:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:17 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:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:17 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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:17 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:37:17 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:37:17 INFO - Using env: {'DISPLAY': ':0', 06:37:17 INFO - 'HOME': '/home/cltbld', 06:37:17 INFO - 'LANG': 'en_US.UTF-8', 06:37:17 INFO - 'LANGUAGE': 'en_US:en', 06:37:17 INFO - 'LOGNAME': 'cltbld', 06:37:17 INFO - 'MAIL': '/var/mail/cltbld', 06:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:17 INFO - 'MOZ_NO_REMOTE': '1', 06:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:17 INFO - 'NO_EM_RESTART': '1', 06:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:17 INFO - 'PWD': '/builds/slave/test', 06:37:17 INFO - 'SHELL': '/bin/bash', 06:37:17 INFO - 'SHLVL': '1', 06:37:17 INFO - 'TERM': 'linux', 06:37:17 INFO - 'TMOUT': '86400', 06:37:17 INFO - 'USER': 'cltbld', 06:37:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:17 INFO - '_': '/tools/buildbot/bin/python'} 06:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:17 INFO - Downloading/unpacking jsonschema==2.5.1 06:37:17 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:37:17 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:37:17 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:37:17 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:37:17 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:37:17 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:37:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:37:19 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:37:19 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:37:19 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:37:19 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:37:19 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:37:19 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:37:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:20 INFO - warning: no files found matching '*.txt' 06:37:20 INFO - no previously-included directories found matching 'build' 06:37:20 INFO - no previously-included directories found matching 'dist' 06:37:20 INFO - no previously-included directories found matching '.git*' 06:37:20 INFO - Installing collected packages: jsonschema, functools32 06:37:20 INFO - Running setup.py install for functools32 06:37:20 INFO - warning: no files found matching '*.txt' 06:37:20 INFO - no previously-included directories found matching 'build' 06:37:20 INFO - no previously-included directories found matching 'dist' 06:37:20 INFO - no previously-included directories found matching '.git*' 06:37:20 INFO - Successfully installed jsonschema functools32 06:37:20 INFO - Cleaning up... 06:37:20 INFO - Return code: 0 06:37:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:37:20 INFO - Using env: {'DISPLAY': ':0', 06:37:20 INFO - 'HOME': '/home/cltbld', 06:37:20 INFO - 'LANG': 'en_US.UTF-8', 06:37:20 INFO - 'LANGUAGE': 'en_US:en', 06:37:20 INFO - 'LOGNAME': 'cltbld', 06:37:20 INFO - 'MAIL': '/var/mail/cltbld', 06:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:20 INFO - 'MOZ_NO_REMOTE': '1', 06:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:20 INFO - 'NO_EM_RESTART': '1', 06:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:20 INFO - 'PWD': '/builds/slave/test', 06:37:20 INFO - 'SHELL': '/bin/bash', 06:37:20 INFO - 'SHLVL': '1', 06:37:20 INFO - 'TERM': 'linux', 06:37:20 INFO - 'TMOUT': '86400', 06:37:20 INFO - 'USER': 'cltbld', 06:37:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:20 INFO - '_': '/tools/buildbot/bin/python'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:37:20 INFO - Cleaning up... 06:37:20 INFO - Return code: 0 06:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:37:20 INFO - Using env: {'DISPLAY': ':0', 06:37:20 INFO - 'HOME': '/home/cltbld', 06:37:20 INFO - 'LANG': 'en_US.UTF-8', 06:37:20 INFO - 'LANGUAGE': 'en_US:en', 06:37:20 INFO - 'LOGNAME': 'cltbld', 06:37:20 INFO - 'MAIL': '/var/mail/cltbld', 06:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:20 INFO - 'MOZ_NO_REMOTE': '1', 06:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:20 INFO - 'NO_EM_RESTART': '1', 06:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:20 INFO - 'PWD': '/builds/slave/test', 06:37:20 INFO - 'SHELL': '/bin/bash', 06:37:20 INFO - 'SHLVL': '1', 06:37:20 INFO - 'TERM': 'linux', 06:37:20 INFO - 'TMOUT': '86400', 06:37:20 INFO - 'USER': 'cltbld', 06:37:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:20 INFO - '_': '/tools/buildbot/bin/python'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:23 INFO - Downloading docopt-0.6.1.tar.gz 06:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:23 INFO - Running setup.py install for blobuploader 06:37:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:23 INFO - Running setup.py install for requests 06:37:23 INFO - Running setup.py install for docopt 06:37:23 INFO - Successfully installed blobuploader requests docopt 06:37:23 INFO - Cleaning up... 06:37:24 INFO - Return code: 0 06:37:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:24 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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:24 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:37:24 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:37:24 INFO - Using env: {'DISPLAY': ':0', 06:37:24 INFO - 'HOME': '/home/cltbld', 06:37:24 INFO - 'LANG': 'en_US.UTF-8', 06:37:24 INFO - 'LANGUAGE': 'en_US:en', 06:37:24 INFO - 'LOGNAME': 'cltbld', 06:37:24 INFO - 'MAIL': '/var/mail/cltbld', 06:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:24 INFO - 'MOZ_NO_REMOTE': '1', 06:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:24 INFO - 'NO_EM_RESTART': '1', 06:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:24 INFO - 'PWD': '/builds/slave/test', 06:37:24 INFO - 'SHELL': '/bin/bash', 06:37:24 INFO - 'SHLVL': '1', 06:37:24 INFO - 'TERM': 'linux', 06:37:24 INFO - 'TMOUT': '86400', 06:37:24 INFO - 'USER': 'cltbld', 06:37:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:24 INFO - '_': '/tools/buildbot/bin/python'} 06:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:24 INFO - Running setup.py (path:/tmp/pip-IS9U6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:24 INFO - Running setup.py (path:/tmp/pip-JMXPRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:24 INFO - Running setup.py (path:/tmp/pip-9DpkjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:24 INFO - Running setup.py (path:/tmp/pip-e8kUWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:24 INFO - Running setup.py (path:/tmp/pip-bGcZII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:24 INFO - Running setup.py (path:/tmp/pip-hbPFKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:24 INFO - Running setup.py (path:/tmp/pip-K4Ik5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:24 INFO - Running setup.py (path:/tmp/pip-cuZUFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:24 INFO - Running setup.py (path:/tmp/pip-vZVV6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:24 INFO - Running setup.py (path:/tmp/pip-9GDwxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:24 INFO - Running setup.py (path:/tmp/pip-FGxZ63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:25 INFO - Running setup.py (path:/tmp/pip-7B5UMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:25 INFO - Running setup.py (path:/tmp/pip-kUbWxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:25 INFO - Running setup.py (path:/tmp/pip-3pzYbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:25 INFO - Running setup.py (path:/tmp/pip-y7fo7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:25 INFO - Running setup.py (path:/tmp/pip-ih5kq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:25 INFO - Running setup.py (path:/tmp/pip-Nca62l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:25 INFO - Running setup.py install for manifestparser 06:37:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:25 INFO - Running setup.py install for mozcrash 06:37:25 INFO - Running setup.py install for mozdebug 06:37:25 INFO - Running setup.py install for mozdevice 06:37:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:25 INFO - Running setup.py install for mozfile 06:37:25 INFO - Running setup.py install for mozhttpd 06:37:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozinfo 06:37:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozInstall 06:37:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozleak 06:37:26 INFO - Running setup.py install for mozlog 06:37:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for moznetwork 06:37:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozprocess 06:37:26 INFO - Running setup.py install for mozprofile 06:37:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozrunner 06:37:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:26 INFO - Running setup.py install for mozscreenshot 06:37:27 INFO - Running setup.py install for moztest 06:37:27 INFO - Running setup.py install for mozversion 06:37:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:27 INFO - Cleaning up... 06:37:27 INFO - Return code: 0 06:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:27 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:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:27 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:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:27 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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:27 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:37:27 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:37:27 INFO - Using env: {'DISPLAY': ':0', 06:37:27 INFO - 'HOME': '/home/cltbld', 06:37:27 INFO - 'LANG': 'en_US.UTF-8', 06:37:27 INFO - 'LANGUAGE': 'en_US:en', 06:37:27 INFO - 'LOGNAME': 'cltbld', 06:37:27 INFO - 'MAIL': '/var/mail/cltbld', 06:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:27 INFO - 'MOZ_NO_REMOTE': '1', 06:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:27 INFO - 'NO_EM_RESTART': '1', 06:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:27 INFO - 'PWD': '/builds/slave/test', 06:37:27 INFO - 'SHELL': '/bin/bash', 06:37:27 INFO - 'SHLVL': '1', 06:37:27 INFO - 'TERM': 'linux', 06:37:27 INFO - 'TMOUT': '86400', 06:37:27 INFO - 'USER': 'cltbld', 06:37:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:27 INFO - '_': '/tools/buildbot/bin/python'} 06:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:27 INFO - Running setup.py (path:/tmp/pip-Vevznz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:27 INFO - Running setup.py (path:/tmp/pip-deVoeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:27 INFO - Running setup.py (path:/tmp/pip-SsJvq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:27 INFO - Running setup.py (path:/tmp/pip-D7d2YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:27 INFO - Running setup.py (path:/tmp/pip-Tc5MPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:27 INFO - Running setup.py (path:/tmp/pip-PBcewj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:27 INFO - Running setup.py (path:/tmp/pip-wfZeGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:27 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:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:27 INFO - Running setup.py (path:/tmp/pip-HV14xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:28 INFO - Running setup.py (path:/tmp/pip-OFoONY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:28 INFO - Running setup.py (path:/tmp/pip-Zao9rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:28 INFO - Running setup.py (path:/tmp/pip-YtHfE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:28 INFO - Running setup.py (path:/tmp/pip-tNJTYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:28 INFO - Running setup.py (path:/tmp/pip-FCb_Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:28 INFO - Running setup.py (path:/tmp/pip-bsdqN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:28 INFO - Running setup.py (path:/tmp/pip-RxS6vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:28 INFO - Running setup.py (path:/tmp/pip-Vrfj4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:28 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:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:28 INFO - Running setup.py (path:/tmp/pip-zz0FXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:30 INFO - Downloading blessings-1.6.tar.gz 06:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:30 INFO - Installing collected packages: blessings 06:37:30 INFO - Running setup.py install for blessings 06:37:30 INFO - Successfully installed blessings 06:37:30 INFO - Cleaning up... 06:37:30 INFO - Return code: 0 06:37:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:31 INFO - Reading from file tmpfile_stdout 06:37:31 INFO - Current package versions: 06:37:31 INFO - argparse == 1.2.1 06:37:31 INFO - blessings == 1.6 06:37:31 INFO - blobuploader == 1.2.4 06:37:31 INFO - docopt == 0.6.1 06:37:31 INFO - functools32 == 3.2.3-2 06:37:31 INFO - jsonschema == 2.5.1 06:37:31 INFO - manifestparser == 1.1 06:37:31 INFO - mozInstall == 1.12 06:37:31 INFO - mozcrash == 0.17 06:37:31 INFO - mozdebug == 0.1 06:37:31 INFO - mozdevice == 0.48 06:37:31 INFO - mozfile == 1.2 06:37:31 INFO - mozhttpd == 0.7 06:37:31 INFO - mozinfo == 0.9 06:37:31 INFO - mozleak == 0.1 06:37:31 INFO - mozlog == 3.4 06:37:31 INFO - moznetwork == 0.27 06:37:31 INFO - mozprocess == 0.23 06:37:31 INFO - mozprofile == 0.28 06:37:31 INFO - mozrunner == 6.12 06:37:31 INFO - mozscreenshot == 0.1 06:37:31 INFO - mozsystemmonitor == 0.3 06:37:31 INFO - moztest == 0.7 06:37:31 INFO - mozversion == 1.4 06:37:31 INFO - psutil == 3.1.1 06:37:31 INFO - requests == 1.2.3 06:37:31 INFO - wsgiref == 0.1.2 06:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:31 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:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:31 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:37:31 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:37:31 INFO - Using env: {'DISPLAY': ':0', 06:37:31 INFO - 'HOME': '/home/cltbld', 06:37:31 INFO - 'LANG': 'en_US.UTF-8', 06:37:31 INFO - 'LANGUAGE': 'en_US:en', 06:37:31 INFO - 'LOGNAME': 'cltbld', 06:37:31 INFO - 'MAIL': '/var/mail/cltbld', 06:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:31 INFO - 'MOZ_NO_REMOTE': '1', 06:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:31 INFO - 'NO_EM_RESTART': '1', 06:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:31 INFO - 'PWD': '/builds/slave/test', 06:37:31 INFO - 'SHELL': '/bin/bash', 06:37:31 INFO - 'SHLVL': '1', 06:37:31 INFO - 'TERM': 'linux', 06:37:31 INFO - 'TMOUT': '86400', 06:37:31 INFO - 'USER': 'cltbld', 06:37:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:31 INFO - '_': '/tools/buildbot/bin/python'} 06:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 INFO - Cleaning up... 06:37:31 INFO - Return code: 0 06:37:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:31 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:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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 0x7fc30cb32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, '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': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', '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:37:31 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:37:31 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:37:31 INFO - Using env: {'DISPLAY': ':0', 06:37:31 INFO - 'HOME': '/home/cltbld', 06:37:31 INFO - 'LANG': 'en_US.UTF-8', 06:37:31 INFO - 'LANGUAGE': 'en_US:en', 06:37:31 INFO - 'LOGNAME': 'cltbld', 06:37:31 INFO - 'MAIL': '/var/mail/cltbld', 06:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:31 INFO - 'MOZ_NO_REMOTE': '1', 06:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:31 INFO - 'NO_EM_RESTART': '1', 06:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:31 INFO - 'PWD': '/builds/slave/test', 06:37:31 INFO - 'SHELL': '/bin/bash', 06:37:31 INFO - 'SHLVL': '1', 06:37:31 INFO - 'TERM': 'linux', 06:37:31 INFO - 'TMOUT': '86400', 06:37:31 INFO - 'USER': 'cltbld', 06:37:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:31 INFO - '_': '/tools/buildbot/bin/python'} 06:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:37:31 INFO - Cleaning up... 06:37:31 INFO - Return code: 0 06:37:31 INFO - Running post-action listener: _resource_record_post_action 06:37:31 INFO - Running post-action listener: _start_resource_monitoring 06:37:31 INFO - Starting resource monitoring. 06:37:31 INFO - [mozharness: 2016-09-26 13:37:31.536973Z] Finished create-virtualenv step (success) 06:37:31 INFO - [mozharness: 2016-09-26 13:37:31.537529Z] Running install step. 06:37:31 INFO - Running pre-action listener: _resource_record_pre_action 06:37:31 INFO - Running main action method: install 06:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:31 INFO - Reading from file tmpfile_stdout 06:37:31 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:31 INFO - Reading from file tmpfile_stdout 06:37:31 INFO - Output received: 06:37:31 INFO - Usage: mozinstall [options] installer 06:37:31 INFO - Options: 06:37:31 INFO - -h, --help show this help message and exit 06:37:31 INFO - -d DEST, --destination=DEST 06:37:31 INFO - Directory to install application into. [default: 06:37:31 INFO - "/builds/slave/test"] 06:37:31 INFO - --app=APP Application being installed. [default: firefox] 06:37:31 INFO - mkdir: /builds/slave/test/build/application 06:37:31 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:37:31 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:37:47 INFO - Reading from file tmpfile_stdout 06:37:47 INFO - Output received: 06:37:47 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - [mozharness: 2016-09-26 13:37:47.900608Z] Finished install step (success) 06:37:47 INFO - [mozharness: 2016-09-26 13:37:47.900851Z] Running run-tests step. 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: run_tests 06:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:47 INFO - Python 2.7.3 06:37:47 INFO - Return code: 0 06:37:47 INFO - grabbing minidump binary from tooltool 06:37: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:37:47 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 0x14fff60>, '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 0x1500d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15011d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:47 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:37:47 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:37:47 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:37:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:47 INFO - Return code: 0 06:37:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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:37:47 INFO - Using env: {'DISPLAY': ':0', 06:37:47 INFO - 'HOME': '/home/cltbld', 06:37:47 INFO - 'LANG': 'en_US.UTF-8', 06:37:47 INFO - 'LANGUAGE': 'en_US:en', 06:37:47 INFO - 'LOGNAME': 'cltbld', 06:37:47 INFO - 'MAIL': '/var/mail/cltbld', 06:37:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:47 INFO - 'MOZ_NO_REMOTE': '1', 06:37:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:47 INFO - 'NO_EM_RESTART': '1', 06:37:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:47 INFO - 'PWD': '/builds/slave/test', 06:37:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:47 INFO - 'SHELL': '/bin/bash', 06:37:47 INFO - 'SHLVL': '1', 06:37:47 INFO - 'TERM': 'linux', 06:37:47 INFO - 'TMOUT': '86400', 06:37:47 INFO - 'USER': 'cltbld', 06:37:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1474896705.325651-238013076', 06:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:47 INFO - '_': '/tools/buildbot/bin/python'} 06:37:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:37:48 INFO - mozversion application_buildid: 20160926041252 06:37:48 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 06:37:48 INFO - mozversion application_display_name: Nightly 06:37:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:48 INFO - mozversion application_name: Firefox 06:37:48 INFO - mozversion application_remotingname: firefox 06:37:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:37:48 INFO - mozversion application_vendor: Mozilla 06:37:48 INFO - mozversion application_version: 52.0a1 06:37:48 INFO - mozversion platform_buildid: 20160926041252 06:37:48 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 06:37:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:37:48 INFO - mozversion platform_version: 52.0a1 06:37:48 INFO - using testdate: 1474897068 06:37:48 INFO - actual date: 1474897068 06:37:48 INFO - starting webserver on 'localhost:39673' 06:37:48 INFO - SUITE-START | Running 2 tests 06:37:48 INFO - TEST-START | dromaeo_css 06:37:48 INFO - operating with platform_type : linux_ 06:37:48 INFO - Initialising browser for dromaeo_css test... 06:37:48 INFO - TEST-INFO | started process 5554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCTnia_/profile http://localhost:39673/getInfo.html) 06:37:53 INFO - PROCESS | 5554 | __metrics Screen width/height:1600/1200 06:37:53 INFO - PROCESS | 5554 | colorDepth:24 06:37:53 INFO - PROCESS | 5554 | Browser inner width/height: 1024/697 06:37:53 INFO - PROCESS | 5554 | __metrics 06:37:54 INFO - PROCESS | 5554 | 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:37:54 INFO - PROCESS | 5554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:54 INFO - PROCESS | 5554 | console.error: PushService: 06:37:54 INFO - PROCESS | 5554 | stateChangeProcessEnqueue: Error transitioning state 06:37:54 INFO - PROCESS | 5554 | UnknownError 06:37:55 INFO - TEST-INFO | 5554: exit 0 06:37:55 INFO - Browser initialized. 06:37:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:55 INFO - TEST-INFO | started process 5637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCTnia_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:07 INFO - PROCESS | 5637 | RSS: Main: 175374336 06:38:07 INFO - PROCESS | 5637 | 06:38:59 INFO - PROCESS | 5637 | 1474897139289 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:41:11 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39673/tests/dromaeo/cssquery-ext.html) 06:41:13 INFO - PROCESS | 5637 | RSS: Main: 271699968 06:41:13 INFO - PROCESS | 5637 | 06:44:15 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-ext.html (next: http://localhost:39673/tests/dromaeo/cssquery-jquery.html) 06:44:16 INFO - PROCESS | 5637 | RSS: Main: 282832896 06:44:16 INFO - PROCESS | 5637 | 06:47:18 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39673/tests/dromaeo/cssquery-mootools.html) 06:47:19 INFO - PROCESS | 5637 | RSS: Main: 261050368 06:47:19 INFO - PROCESS | 5637 | 06:50:21 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39673/tests/dromaeo/cssquery-prototype.html) 06:50:22 INFO - PROCESS | 5637 | RSS: Main: 240238592 06:50:22 INFO - PROCESS | 5637 | 06:53:25 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39673/tests/dromaeo/cssquery-yui.html) 06:53:25 INFO - PROCESS | 5637 | RSS: Main: 220901376 06:53:25 INFO - PROCESS | 5637 | 06:56:28 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:39673/tests/dromaeo/cssquery-yui.html (next: http://localhost:39673/tests/dromaeo/cssquery-dojo.html) 06:56:29 INFO - PROCESS | 5637 | RSS: Main: 310689792 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | __start_tp_report 06:56:29 INFO - PROCESS | 5637 | _x_x_mozilla_page_load 06:56:29 INFO - PROCESS | 5637 | _x_x_mozilla_page_load_details 06:56:29 INFO - PROCESS | 5637 | |i|pagename|runs| 06:56:29 INFO - PROCESS | 5637 | |0;dojo.html;2558.59062549992;2582.75463830936;2625.4880298341827;2633.157389635316;2634.4599357131788;4475.507694153641;4554.658400619958;4679.602233810126;4696.483386827451;4709.976450117753;4590.701604395712;4624.2370008948565;4655.4413470383515;4686.390769199999;4744.881377965544;4268.338407546835;4295.312749960007;4307.504636966758;4327.502337231212;4347.760873151976;4321.9783901080455;4400.939236919549;4402.845900393487;4406.97796511017;4416.205083085043;4186.602272784081;4348.1086377292895;4355.847545335898;4369.803358848843;4463.375127482139;4224.112936283384;4265.552117027699;4283.614474697292;4302.376155457441;4345.239583072949;4300.462442194726;4301.892452688677;4304;4362.083962367907;4367.737935723867;4698.7650617469335;4703.6237101032175;4720.834770783006;4721.457032441279;4733.313669517901;4849.418069831608;4906.215005599122;4947.925781113287;5004.624653150991;5029.673071250357;5018.4981501849525;5022.196448568212;5022.84931452057;5053.8231161909525;5069.467705890866;4664.346991421204;4672.789724462339;4672.789724462339;4676.672632915731;4732.290156476487;4969.552740253323;4998.925016124761;5034.521720436626;5118.334616499831;5178.974105129526;4805.495422980606;4808.807647694123;4813;4874.025194961022;4883.926741098886;4875.463698993108;4879.365682461257;4882.536159064884;4883.389576302962;4950.950490495049;4772.665913386029;4825;4841.080194762983;4846.055019271208;4921.335619691367;4931.876703082452;4967.627427942919;4989.027139707722;5045.722485263345;5050.217216331474;4282.314829627245;4282.978585107055;4301.483821941387;4331.97834010828;4339;3708.4437334399518;3743.1577894973957;3747.868824591126;3775.9433608495897;3797.5442946846556;4192.895177620584;4239.04621460169;4243.724157929724;4329.112531930947;4386.18855511725;4940.283658869444;4950.8267210647455;4954.801807927714;4963.329950456642;4965.751712414365;4269.5090064642345;4273.87178384649;4316.050468896838;4321.308590625485;4370.475542934868;4543.636509079266;4546.272596384629;4588.770561471913;4593.931091033637;4599.310103484504;4721.126591580569;4750.311204875274;4753.049390122059;4756.833510827174;4812.5668689818085;4850.320955066223;4931;4951.777170027285;4971.105201063843;5023.623228257969;4728.692634978715;4731.243001119804;4744.264638980963;4797.616190704805;4822.348982887265;4935.037667654773;4942.604591632589;4947.628927830499;4969.577585905238;5006.62450316235;4793.9041219176115;4888.780004899859;5013.924791128063;5031.446540880451;5081.339425874613;4832.516748325139;4858.295547145714;4884.1941079722865;4896.559309662148;4955.925661115014;4862;4885.926711099265;4887.731174785279;4912;4951.084049450863;4655.3249778782565;4714.811407543797;4840.201366774443;4847.103285892122;4893.877653058702;4887.804487820589;4927.137750893651;4959.0329885671945;4961.677490963076;5019.874503137451;4844.346013288302;4853.320535125014;4860.708357498562;4866.852612303246;4901.950980490149 06:56:29 INFO - PROCESS | 5637 | |1;ext.html;556.5742207211483;573.0401577357926;576.0955300178719;577.312997532936;585.6515373352854;30535.236619084535;31359;31422.84288578557;31469.68530314696;31479;31296.687033129663;39061;40608;40614.39078413826;44305.77847110768;7546.2831031051965;7697.0378702662165;7705.422093342993;7707.30634242918;7710.113336966237;7591.278828511283;7681.57751323677;7686.961565192194;7688.807779805494;7690.846183076335;7674.769756907302;7716.074071111474;7718.189590093044;7719.691212351528;7722.652480638385;7639.04511936008;7690.15408305086;7704.537727736354;7704.6532906019365;7710.7686769397005;7561.659725312319;7639.847203055963;7641.808954776119;7643.617819109078;7644.044494438195;36391.818040909624;36693;36767.63232367669;36802;36806.26387472262;2926.2391778137626;3044.2237229506336;3290.7696461247483;3300.488424294238;3617.4935509028755;26234.86882565575;28539.57190642142;28857.278568035756;28974.565381519293;28982.565261521093;3445.5693038370205;3502.2995400919917;3607.837647305851;3655.817209139532;3658.3414985302634;252228;252964;255003;255107.72446137836;256361;30934.81303739261;54059;54608;54636.72681636566;54644.25691889279;31197.376052478823;33733.325333493194;33740;33751;33755.32489350248;12840.807387889003;12845.807312890314;13059.869401306056;13061.542846000344;13069;10303.639372621923;10465.84301235482;10515.211359148094;10532.05211530966;10561.841572376421;7716.4212684048925;7747.38020958322;7775.079821438343;7809.414293927978;7854.607269636495;3004.23392035034;3038.2252525605827;3052.8168309901475;3065.9540106898417;3066.494028485275;808.8584497712877;817.9141190175066;853.7865533616596;873.8296032273772;944.560779237644;25323.87338063298;27395.315117121834;27617;27785.44429111447;28041.43917121687;778.7118766056595;912.7444315591645;918.5315489100607;948.6300342866288;948.8861336639509;13830.74259120514;14909.850901491063;15062.548123556311;15153.166575838435;15167.696646067017;361084;361201;361261;362490;364770;47474.762626186646;47870.5212947873;47908.28137577939;47919.76040119777;48378.516214838106;1048.0933992096782;1097.9451027448595;1103.0734183286079;1163.5229555882047;1182.781185480689;23076.538469230858;28543.857280714295;29502.787290952834;31289.8435507821;31302.686973129978;46472.30291545562;47325.52674473211;47388.7630561845;47411.28883066826;47445.52554474549;306204;306730;306923;307052;307222;24330.75669243285;25064.248072557853;25113.87443062773;25402.237932862045;25505.74494255108;41018;41046.79476602598;41139.7943010295;41140.58859411367;41407.792961035004;34832.82583587066;34856.47715284323;34937;34983.300333992665;35154.64845351616;32789;34677.47983780296;34925.47611785775;34926.30147397089;35017.649823502456;29440.852795735886;29945.101646950625;35294.11764705903;35422.822885885405;35781.46327805137;29071.7092829069;30959.226019349695;31475.84262078675;31793.841030794698;32000;24877.38787427294;25002;25040.248792536255;25161.622575661746;25459.87270063712 06:56:29 INFO - PROCESS | 5637 | |2;jquery.html;359.82728290420596;367.22515492311226;370.21329674441813;380.950476438063;383.9731218814684;15563.377464901405;16670.749938750912;16967.915160424196;17213.91393043036;17267.91366043168;16348.918255408706;17059;17067.658646827054;17213.13934303286;17228.655426891455;4723.881902952419;4970.229614409773;4977.527134922195;4978.800847966077;4983.127952608297;3689.594144644087;3879.4180872869156;4994.87512812179;5574.609777315569;5825.446582574648;5904.439078287556;5904.734286957076;5906.2912450506;5912.231409916705;5950.315713692916;5691.4877661010505;5921.73352199152;5953.910691339634;5970.761169553212;5974.312954010301;5103.795848166069;5266.578673706094;5267.236250743659;5268.5521730652945;5269.262303277545;20148.597028059503;20254.79745202544;20286.69569956452;20586.382408527767;20606.175752969863;1834.1562881074722;1891.8202770736757;2046.8567200295986;2189.4745261137373;2382.0114652419225;12505.249685018927;12975;13548.390322435514;13672.453101875913;13706.314684265746;1647.5057482755246;1650.207900207907;1720.9913950430168;1753.0883940350946;1834.1929550997518;63887;65818.67090664516;66570.66714666395;67354.32645673529;68492.31507684909;9253;9411.717648470556;9590.712278631652;9732;9933.205343572497;13335.733285334432;13360.064795464225;13381.330933453288;13382.866171338163;13388.129771564818;6914.446844252448;7038.5073044887395;7098.822529436702;7151.53515021522;7162.140543134858;6550.7573750992615;6653.800385988428;6828.487863410264;6841.657917104125;6861.279565645636;6133.325334213233;6220.782272620437;6249.062640603855;6251.3123556408755;6414.61512309263;1658.8507034366723;1696.9321227151022;1745;1779.17268470162;1791.6774980503635;855.4696088425217;869.6130222051253;877.3113106211721;877.3551439691821;891.1623074310128;16718;16859.24133413999;17603.911980440014;17679.823201768075;18037;802.5425507460808;813.2680587471323;853.1894700034992;883.7481317824389;948.3266880514911;9690.321677482649;10221.43782091992;10267.486625668687;10274.721707559394;10362.740931476774;324868;325799;326181;326358;339358;41258;50352.181324641344;64727.67636161789;65020.34979650238;68072.65963670249;789.8420315936836;806.2944923192324;844.6663567890772;866.3242670716851;867.6355930509075;15089.773653395427;15639;16315.18424078815;16337.509874703777;16499.83500165031;32436;33708.49437258492;33725.3254934895;34318.65681343254;34721.826390867885;41792.79103604584;42614.08236629297;43436.56563434325;43800;44747.77626111849;4769.880752981203;4996.150654388835;6917.757878474229;7550.942867998375;7836.177201394;11109.722256943318;11512.481938312963;11764.411779411166;11839.644810655695;12254.080943929062;9686.612535498502;10185.49072546355;10425.426601536685;10428.791424171626;10681.19891008193;9908.207343412654;10066.245031622804;10132.290739648153;10185.79628407413;10503.369797812156;10303.278770486293;10321.277510574188;10762.946185269024;10814.945925270324;10981;7642;7717.305442510201;7879;7882.960585197037;7915.762527124196;10146.086852183338;10432.895671043192;10488.475576221006;10528.578856845947;10831.24181307301 06:56:29 INFO - PROCESS | 5637 | |3;mootools.html;1292.6057552446505;1352.0265408905589;1362.960597866757;1606.6063814365482;1646.4566692991314;6422.646754428516;6693.129893113888;7031.296870312966;7582.2038685938005;7583.203763604824;7164.570125792443;7412.703491860332;7442.590657513834;7660.885086723703;7664.11862635797;2100.9159633614636;2128.531723020933;2131.9040643171015;2134.743830740313;2135.0819147766456;1822.4259358302158;1891.6216756648657;2075.2425364741835;2091.4771307173205;2139.70044193813;1905.3236101184089;1920.0591710062108;1925.1048262557908;2053.5276886316155;2131.6269652810774;2037.1749441476227;2039.4391542325832;2041.8162365387038;2042.4893776555862;2042.4893776555862;2047.1811275489922;2055.599158164159;2072.927447539329;2106.241752968945;2108.599366120432;7603.695852165962;7699.653515591812;7753.844923101563;7755.573443460607;7777.961110194469;4439.2675208590545;4552.544745525454;4553.567411095941;4556.954430455686;4560.977195114003;2849.5298275784676;2889;2938.603288556039;2960.1119664100897;2968.139239620529;886.5478605910968;904.4482865452069;917.312015988009;930.6417029443645;931.5109567477128;10342.172626189888;10387.11709504693;10398.896011039868;10402.843957340647;10405.687829365132;3995.820188091543;4004.4794176756836;4205.705600607928;4236.661067114624;4250.42619246404;8982.640694372283;9008.909910900938;9017.413868098552;9018.549072546477;9022.097790220925;4666.719996800203;4689.366935463669;4691.413573303337;4691.413573303337;4699.412573428322;4192.392103145027;4281.571842815693;4283.2932566126865;4286.6999310047995;4287.249731297073;3512.8243587820507;3596.6403359664346;3616.9638303617153;3790.753601015925;3792.6965842732516;1099.8075336816025;1102.8731695855079;1128.5260190719916;1143.0912424622445;1153.7692461507731;654.4044919123575;800.1118758178417;801.9238172373615;804.9393552505487;821.2280456370992;5148;5204.0372531081875;5272.7100009499845;5277.656952298088;5319.228711836762;409.78281510799326;412.51117425850464;413.83032956488296;414.13652534465376;416.0223474834116;3572.2676851245433;3579.51676523666;3662.322470342995;3677.669009789132;3984.442178095069;9019.143181397756;9215.585298661576;9287.442753434816;9321.207697345802;9323.160915517636;9270.44377337362;9282.675106371245;9284.95357523208;9289.256859451227;9297.070292970784;6997.195322537973;7274.890876636855;7282.053333066668;7284.49008569395;7290.125184977836;5126.9743651283;5178.404483484447;5201.297824793604;5212.661177023481;5349.518543331119;8492.532910689724;8526.104759000216;8716.694915677921;8778.07521221216;8868.645254190018;8715.869261960948;8979.46123232608;9005.324600654845;9061.048589897966;9072.95463522678;6283.497320214463;6390.265119511316;6444.226692796894;6445.581037232565;6458.967705161444;7038.155421349471;7086.39765619928;7147.571145731273;7148.213696493485;7148.499605027599;6347.619142851444;6416.454601358937;6484.319146489739;6502.739890404331;6505;6538.1827271591055;6541.6402097883165;6546.770863019771;6563.409293163638;6580.703868325841;5993.730282137227;5995.46040856325;6005.309389420097;6051.939480605138;6063.333033366414;4269.359596060492;4302.978485107555;4313.180495705806;4376.781160942004;4496.7077139985795;4263.850765223202;4294.227039132986;4297.076128632234;4500.842470513517;4518.277075667877 06:56:29 INFO - PROCESS | 5637 | |4;prototype.html;274.6059404754179;290.6686377529615;295.63932002956386;300.6032037710222;305.5599936092027;4584.4040274764275;4718.598919091877;4835.1296766582;4852.902941941159;4870.464248932614;4719.292106184074;4813.446453657831;4826.806927722887;4826.831060912868;4836.903261934768;3802.448644946481;3821.5414150302004;3824.3689791184493;3836.462895194675;3853.3834586466173;3585.94621080684;3662.963370366302;3696.7431073435027;3815.9046023849346;3818.4081467372603;3740.9438858417147;3741.5323084614424;3742.719296052793;3749.343864823659;3752.924941501168;3726.944095838551;3733.272011957683;3764.0589852536864;3768.660820526138;3777.5655799583124;3343.866245350183;3352.5306457096026;3356.446186379269;3358.748093892968;3374.5950485941844;4506.774661266923;4548.2268014437295;4577.56513131252;4580.312953057035;4580.335851301543;4243.851465198734;4249.447571815645;4259.148170365939;4268.9573104268875;4273.18809426208;4898;4922.360093187863;4928.349003083971;4929.186684197139;4957.82647607332;3361.4201325377035;3543.982280088583;3544.7518673692853;3612.187257866959;3614.34941710492;5167.405748338914;5188.299579556749;5188.870278243036;5205.531502164823;5206;3638.8544458221904;3642.1440961374055;3644.2164934538673;3648.3980143276062;3656.2687462507074;3678.779273243614;3704.9259014819554;3712.461693054546;3730.1047748540695;3739.551253849501;3995.9400608990886;4023.2355852387955;4066.3290557057753;4110.547839737626;4248.426462427533;5003.524665156804;5007.973365460072;5010.3737032870895;5012.298278241049;5013.3983921928875;1264.6332563556466;1279.6992706713916;1281.9744204636254;1284.1332100832087;1288.67138879587;793.15132807895;817.2644619842071;820.4134044158455;829.4732844643695;835.3734698975768;3956.940645890314;3960;3968.948228719334;3969.4442778011103;3975.3241948868763;4503.639708823286;4507.323901414748;4509.6392288616835;4518.774061296922;4526.411566496335;3967.3535482774323;3976.8011599419915;3988.823297127354;3989.7606143631474;4002.939955900664;2313.4679023824615;2394.916177933764;2413.951720965571;2423.6122220444645;2428.599281118631;4290.678199135077;4298.441202643637;4313.266744653416;4330.523642399334;4334;4581.625512346282;4594.977025114853;4605.3387556891685;4608.400907881954;4647.233206520954;4106.609872062149;4293.96944733268;4298.903779536198;4308.655307575386;4315.870523884351;4449.19807477972;4449.688521803443;4467.530909254611;4473.418455600751;4508.774561271857;4409.625181859577;4429.623482004065;4441.7779111044965;4469.620082293041;4490.236659767782;4133.81397837092;4293.82824687009;4306.956930430656;4328.112736888867;4363.214621368184;3269.2807582331848;3280.835958202128;3293.884714034997;3300.9601975377677;3330.1841048943165;4485.600203890903;4529.8641040768825;4584.744831169906;4868.488808675038;5033.622478314214;4934.65603838174;5013.323201367914;5020.598352131894;5028.84913452597;5081.568066714222;4905.950940490549;4995.625328100335;5006.823396501892;5008.348914641073;5021.196608542616;4735.881602959816;4834.71879951806;4894.877628059185;4931.211006238985;4953.578945789648;4969.0807200668;4969.900601987868;4970.279309500174;4972.5276098770555;5003.824866129668;4877.146499362527;4879.536444037811;4917.188663870421;4930.950690493192;4944.703317800943 06:56:29 INFO - PROCESS | 5637 | |5;yui.html;650.7559665125578;716.5485743981291;723.9611157988287;739.5230076600593;745.6719043620803;13534.796978045324;14480.855191448083;14621.561353159395;14659.19374434407;14665.12009279444;13346.466141354358;13367.331633418338;13370.66573335667;13377.39801708923;13381.464741410331;630.7413960276288;744.5346658338525;745.9738909138181;769.9961500192519;775.3796962430062;771.6836097200149;779.976600701977;786.8937693411402;788.771256335662;789.960501974899;828.9461185022984;830.9542975136366;831.55096248026;831.6257684042175;831.683960095163;825.2078005115096;825.628467189764;826.5454000299871;833.9916600834035;834.7287131682167;609.7621927448299;609.9481544068759;610.9847253818646;611.4313688269951;611.5352332227494;12468.501259949591;12494.937525312405;12523.373831308398;12540.122191446602;12540.435680394405;13657.453701852013;13785.448582056706;13813.585592432242;14073.141731382542;14313.71372572553;10704;10729.141668666489;10793.67618971432;11043;11048.171387145916;3271.5910511186103;3313.7680362374645;3316.519104729825;3319.7012268895674;3396.490526421032;38437.61562384368;59329.70335148297;59524.10713839339;64684.67657661728;65948.6702566489;9148.2681385489;9349.672761453316;9579.425234485952;9682.225421966226;10619.84070238947;18423.170957306953;18673.439796806117;18681.532961675795;18706;18709.906450467934;6562.442192413603;6703.363180497845;6798.490113241428;6917.550359226634;7090.822729431806;3629.4737263096704;3666.50502182202;3693.6306369362846;3711.536057992751;3800.0309920969976;2807.4385122975486;2932.706729327093;2934.60382848317;2935.0314396249614;2939.103573410088;492.73884841033595;493.3019777015483;500.2721040885503;509.9774951222849;513.5686023740002;482.8310091467958;483.9733814640158;524.219121610911;526.8709166254216;548.7064420535074;7422.851542969111;7532.246775322424;7537.585432801248;7556.4710470266555;7760.417968652374;442.3652059294922;463.6777439679458;472.21847841821153;479.62828807674333;534.3134072716541;3696.6857817085847;3819.1406933440308;3841.980790096032;3844.6347596978803;3860.2665493556133;96565;97313;98813;102332;102445.48777256066;85682.57158714166;85989.71015434773;87046.56476717576;87764.56117719371;88348;75212.62393688106;75420;75611.08527945666;76499.23500764921;77277.6136119327;6909.170899492093;7137.214906360193;7174.569525828467;7179.282071792779;7206.819829504304;43837.34243986406;44422.999999998705;45178;45277.54722452865;45799.77100114478;64655.35344646681;65104.34895650983;65543.34456655373;67079.32920670926;70874.64562677154;7797.883031754414;8295.751127466187;8396.706115285935;8606.354523410644;8641.265492433213;9252.861207081765;9319.953400232955;9409.717708468757;9968.202543796624;10297.74255643615;8617.426594407694;8674.436161649473;8796.692115775917;8872.86690699627;8932.46405215689;9283.907160928304;9359.391639543408;9464.810703786023;9759.170470510086;9883.159931405911;8376.83246335082;8534.402591818513;8711.69509067205;8749.825003499767;8894.555272236492;8042.95978520127;8251.512744025396;8337.124601916954;8378.45879202628;8468.872966905625;7487.925120748941;7656.119546252252;7672.539647621161;7788.299053085249;7832.530048197126 06:56:29 INFO - PROCESS | 5637 | __end_tp_report 06:56:29 INFO - PROCESS | 5637 | __start_cc_report 06:56:29 INFO - PROCESS | 5637 | _x_x_mozilla_cycle_collect,1134 06:56:29 INFO - PROCESS | 5637 | __end_cc_report 06:56:29 INFO - PROCESS | 5637 | __startTimestamp1474898189070__endTimestamp 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | ------- Summary: start ------- 06:56:29 INFO - PROCESS | 5637 | Number of tests: 6 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#0] dojo.html Cycles:165 Average:4621.91 Median:4753.05 stddev:470.50 (9.9%) stddev-sans-first:443.23 06:56:29 INFO - PROCESS | 5637 | Values: 2558.6 2582.8 2625.5 2633.2 2634.5 4475.5 4554.7 4679.6 4696.5 4710.0 4590.7 4624.2 4655.4 4686.4 4744.9 4268.3 4295.3 4307.5 4327.5 4347.8 4322.0 4400.9 4402.8 4407.0 4416.2 4186.6 4348.1 4355.8 4369.8 4463.4 4224.1 4265.6 4283.6 4302.4 4345.2 4300.5 4301.9 4304.0 4362.1 4367.7 4698.8 4703.6 4720.8 4721.5 4733.3 4849.4 4906.2 4947.9 5004.6 5029.7 5018.5 5022.2 5022.8 5053.8 5069.5 4664.3 4672.8 4672.8 4676.7 4732.3 4969.6 4998.9 5034.5 5118.3 5179.0 4805.5 4808.8 4813.0 4874.0 4883.9 4875.5 4879.4 4882.5 4883.4 4951.0 4772.7 4825.0 4841.1 4846.1 4921.3 4931.9 4967.6 4989.0 5045.7 5050.2 4282.3 4283.0 4301.5 4332.0 4339.0 3708.4 3743.2 3747.9 3775.9 3797.5 4192.9 4239.0 4243.7 4329.1 4386.2 4940.3 4950.8 4954.8 4963.3 4965.8 4269.5 4273.9 4316.1 4321.3 4370.5 4543.6 4546.3 4588.8 4593.9 4599.3 4721.1 4750.3 4753.0 4756.8 4812.6 4850.3 4931.0 4951.8 4971.1 5023.6 4728.7 4731.2 4744.3 4797.6 4822.3 4935.0 4942.6 4947.6 4969.6 5006.6 4793.9 4888.8 5013.9 5031.4 5081.3 4832.5 4858.3 4884.2 4896.6 4955.9 4862.0 4885.9 4887.7 4912.0 4951.1 4655.3 4714.8 4840.2 4847.1 4893.9 4887.8 4927.1 4959.0 4961.7 5019.9 4844.3 4853.3 4860.7 4866.9 4902.0 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#1] ext.html Cycles:180 Average:44877.77 Median:34960.15 stddev:81923.30 (234.3%) stddev-sans-first:82085.53 06:56:29 INFO - PROCESS | 5637 | Values: 556.6 573.0 576.1 577.3 585.7 30535.2 31359.0 31422.8 31469.7 31479.0 31296.7 39061.0 40608.0 40614.4 44305.8 7546.3 7697.0 7705.4 7707.3 7710.1 7591.3 7681.6 7687.0 7688.8 7690.8 7674.8 7716.1 7718.2 7719.7 7722.7 7639.0 7690.2 7704.5 7704.7 7710.8 7561.7 7639.8 7641.8 7643.6 7644.0 36391.8 36693.0 36767.6 36802.0 36806.3 2926.2 3044.2 3290.8 3300.5 3617.5 26234.9 28539.6 28857.3 28974.6 28982.6 3445.6 3502.3 3607.8 3655.8 3658.3 252228.0 252964.0 255003.0 255107.7 256361.0 30934.8 54059.0 54608.0 54636.7 54644.3 31197.4 33733.3 33740.0 33751.0 33755.3 12840.8 12845.8 13059.9 13061.5 13069.0 10303.6 10465.8 10515.2 10532.1 10561.8 7716.4 7747.4 7775.1 7809.4 7854.6 3004.2 3038.2 3052.8 3066.0 3066.5 808.9 817.9 853.8 873.8 944.6 25323.9 27395.3 27617.0 27785.4 28041.4 778.7 912.7 918.5 948.6 948.9 13830.7 14909.9 15062.5 15153.2 15167.7 361084.0 361201.0 361261.0 362490.0 364770.0 47474.8 47870.5 47908.3 47919.8 48378.5 1048.1 1097.9 1103.1 1163.5 1182.8 23076.5 28543.9 29502.8 31289.8 31302.7 46472.3 47325.5 47388.8 47411.3 47445.5 306204.0 306730.0 306923.0 307052.0 307222.0 24330.8 25064.2 25113.9 25402.2 25505.7 41018.0 41046.8 41139.8 41140.6 41407.8 34832.8 34856.5 34937.0 34983.3 35154.6 32789.0 34677.5 34925.5 34926.3 35017.6 29440.9 29945.1 35294.1 35422.8 35781.5 29071.7 30959.2 31475.8 31793.8 32000.0 24877.4 25002.0 25040.2 25161.6 25459.9 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#2] jquery.html Cycles:180 Average:21848.01 Median:375.58 stddev:54082.70 (14399.7%) stddev-sans-first:54210.35 06:56:29 INFO - PROCESS | 5637 | Values: 359.8 367.2 370.2 381.0 384.0 15563.4 16670.7 16967.9 17213.9 17267.9 16348.9 17059.0 17067.7 17213.1 17228.7 4723.9 4970.2 4977.5 4978.8 4983.1 3689.6 3879.4 4994.9 5574.6 5825.4 5904.4 5904.7 5906.3 5912.2 5950.3 5691.5 5921.7 5953.9 5970.8 5974.3 5103.8 5266.6 5267.2 5268.6 5269.3 20148.6 20254.8 20286.7 20586.4 20606.2 1834.2 1891.8 2046.9 2189.5 2382.0 12505.2 12975.0 13548.4 13672.5 13706.3 1647.5 1650.2 1721.0 1753.1 1834.2 63887.0 65818.7 66570.7 67354.3 68492.3 9253.0 9411.7 9590.7 9732.0 9933.2 13335.7 13360.1 13381.3 13382.9 13388.1 6914.4 7038.5 7098.8 7151.5 7162.1 6550.8 6653.8 6828.5 6841.7 6861.3 6133.3 6220.8 6249.1 6251.3 6414.6 1658.9 1696.9 1745.0 1779.2 1791.7 855.5 869.6 877.3 877.4 891.2 16718.0 16859.2 17603.9 17679.8 18037.0 802.5 813.3 853.2 883.7 948.3 9690.3 10221.4 10267.5 10274.7 10362.7 324868.0 325799.0 326181.0 326358.0 339358.0 41258.0 50352.2 64727.7 65020.3 68072.7 789.8 806.3 844.7 866.3 867.6 15089.8 15639.0 16315.2 16337.5 16499.8 32436.0 33708.5 33725.3 34318.7 34721.8 41792.8 42614.1 43436.6 43800.0 44747.8 4769.9 4996.2 6917.8 7550.9 7836.2 11109.7 11512.5 11764.4 11839.6 12254.1 9686.6 10185.5 10425.4 10428.8 10681.2 9908.2 10066.2 10132.3 10185.8 10503.4 10303.3 10321.3 10762.9 10814.9 10981.0 7642.0 7717.3 7879.0 7883.0 7915.8 10146.1 10432.9 10488.5 10528.6 10831.2 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#3] mootools.html Cycles:180 Average:4988.50 Median:5137.49 stddev:2811.07 (54.7%) stddev-sans-first:2805.24 06:56:29 INFO - PROCESS | 5637 | Values: 1292.6 1352.0 1363.0 1606.6 1646.5 6422.6 6693.1 7031.3 7582.2 7583.2 7164.6 7412.7 7442.6 7660.9 7664.1 2100.9 2128.5 2131.9 2134.7 2135.1 1822.4 1891.6 2075.2 2091.5 2139.7 1905.3 1920.1 1925.1 2053.5 2131.6 2037.2 2039.4 2041.8 2042.5 2042.5 2047.2 2055.6 2072.9 2106.2 2108.6 7603.7 7699.7 7753.8 7755.6 7778.0 4439.3 4552.5 4553.6 4557.0 4561.0 2849.5 2889.0 2938.6 2960.1 2968.1 886.5 904.4 917.3 930.6 931.5 10342.2 10387.1 10398.9 10402.8 10405.7 3995.8 4004.5 4205.7 4236.7 4250.4 8982.6 9008.9 9017.4 9018.5 9022.1 4666.7 4689.4 4691.4 4691.4 4699.4 4192.4 4281.6 4283.3 4286.7 4287.2 3512.8 3596.6 3617.0 3790.8 3792.7 1099.8 1102.9 1128.5 1143.1 1153.8 654.4 800.1 801.9 804.9 821.2 5148.0 5204.0 5272.7 5277.7 5319.2 409.8 412.5 413.8 414.1 416.0 3572.3 3579.5 3662.3 3677.7 3984.4 9019.1 9215.6 9287.4 9321.2 9323.2 9270.4 9282.7 9285.0 9289.3 9297.1 6997.2 7274.9 7282.1 7284.5 7290.1 5127.0 5178.4 5201.3 5212.7 5349.5 8492.5 8526.1 8716.7 8778.1 8868.6 8715.9 8979.5 9005.3 9061.0 9073.0 6283.5 6390.3 6444.2 6445.6 6459.0 7038.2 7086.4 7147.6 7148.2 7148.5 6347.6 6416.5 6484.3 6502.7 6505.0 6538.2 6541.6 6546.8 6563.4 6580.7 5993.7 5995.5 6005.3 6051.9 6063.3 4269.4 4303.0 4313.2 4376.8 4496.7 4263.9 4294.2 4297.1 4500.8 4518.3 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#4] prototype.html Cycles:180 Average:3980.63 Median:4321.99 stddev:1143.04 (26.4%) stddev-sans-first:1111.89 06:56:29 INFO - PROCESS | 5637 | Values: 274.6 290.7 295.6 300.6 305.6 4584.4 4718.6 4835.1 4852.9 4870.5 4719.3 4813.4 4826.8 4826.8 4836.9 3802.4 3821.5 3824.4 3836.5 3853.4 3585.9 3663.0 3696.7 3815.9 3818.4 3740.9 3741.5 3742.7 3749.3 3752.9 3726.9 3733.3 3764.1 3768.7 3777.6 3343.9 3352.5 3356.4 3358.7 3374.6 4506.8 4548.2 4577.6 4580.3 4580.3 4243.9 4249.4 4259.1 4269.0 4273.2 4898.0 4922.4 4928.3 4929.2 4957.8 3361.4 3544.0 3544.8 3612.2 3614.3 5167.4 5188.3 5188.9 5205.5 5206.0 3638.9 3642.1 3644.2 3648.4 3656.3 3678.8 3704.9 3712.5 3730.1 3739.6 3995.9 4023.2 4066.3 4110.5 4248.4 5003.5 5008.0 5010.4 5012.3 5013.4 1264.6 1279.7 1282.0 1284.1 1288.7 793.2 817.3 820.4 829.5 835.4 3956.9 3960.0 3968.9 3969.4 3975.3 4503.6 4507.3 4509.6 4518.8 4526.4 3967.4 3976.8 3988.8 3989.8 4002.9 2313.5 2394.9 2414.0 2423.6 2428.6 4290.7 4298.4 4313.3 4330.5 4334.0 4581.6 4595.0 4605.3 4608.4 4647.2 4106.6 4294.0 4298.9 4308.7 4315.9 4449.2 4449.7 4467.5 4473.4 4508.8 4409.6 4429.6 4441.8 4469.6 4490.2 4133.8 4293.8 4307.0 4328.1 4363.2 3269.3 3280.8 3293.9 3301.0 3330.2 4485.6 4529.9 4584.7 4868.5 5033.6 4934.7 5013.3 5020.6 5028.8 5081.6 4906.0 4995.6 5006.8 5008.3 5021.2 4735.9 4834.7 4894.9 4931.2 4953.6 4969.1 4969.9 4970.3 4972.5 5003.8 4877.1 4879.5 4917.2 4931.0 4944.7 06:56:29 INFO - PROCESS | 5637 | 06:56:29 INFO - PROCESS | 5637 | [#5] yui.html Cycles:180 Average:17421.91 Median:36891.35 stddev:26018.56 (70.5%) stddev-sans-first:26061.08 06:56:29 INFO - PROCESS | 5637 | Values: 650.8 716.5 724.0 739.5 745.7 13534.8 14480.9 14621.6 14659.2 14665.1 13346.5 13367.3 13370.7 13377.4 13381.5 630.7 744.5 746.0 770.0 775.4 771.7 780.0 786.9 788.8 790.0 828.9 831.0 831.6 831.6 831.7 825.2 825.6 826.5 834.0 834.7 609.8 609.9 611.0 611.4 611.5 12468.5 12494.9 12523.4 12540.1 12540.4 13657.5 13785.4 13813.6 14073.1 14313.7 10704.0 10729.1 10793.7 11043.0 11048.2 3271.6 3313.8 3316.5 3319.7 3396.5 38437.6 59329.7 59524.1 64684.7 65948.7 9148.3 9349.7 9579.4 9682.2 10619.8 18423.2 18673.4 18681.5 18706.0 18709.9 6562.4 6703.4 6798.5 6917.6 7090.8 3629.5 3666.5 3693.6 3711.5 3800.0 2807.4 2932.7 2934.6 2935.0 2939.1 492.7 493.3 500.3 510.0 513.6 482.8 484.0 524.2 526.9 548.7 7422.9 7532.2 7537.6 7556.5 7760.4 442.4 463.7 472.2 479.6 534.3 3696.7 3819.1 3842.0 3844.6 3860.3 96565.0 97313.0 98813.0 102332.0 102445.5 85682.6 85989.7 87046.6 87764.6 88348.0 75212.6 75420.0 75611.1 76499.2 77277.6 6909.2 7137.2 7174.6 7179.3 7206.8 43837.3 44423.0 45178.0 45277.5 45799.8 64655.4 65104.3 65543.3 67079.3 70874.6 7797.9 8295.8 8396.7 8606.4 8641.3 9252.9 9320.0 9409.7 9968.2 10297.7 8617.4 8674.4 8796.7 8872.9 8932.5 9283.9 9359.4 9464.8 9759.2 9883.2 8376.8 8534.4 8711.7 8749.8 8894.6 8043.0 8251.5 8337.1 8378.5 8468.9 7487.9 7656.1 7672.5 7788.3 7832.5 06:56:29 INFO - PROCESS | 5637 | -------- Summary: end -------- 06:56:29 INFO - PROCESS | 5637 | 06:56:30 INFO - TEST-INFO | 5637: exit 0 06:56:30 INFO - TEST-OK | dromaeo_css | took 1121866ms 06:56:30 INFO - TEST-START | kraken 06:56:30 INFO - operating with platform_type : linux_ 06:56:30 INFO - Initialising browser for kraken test... 06:56:30 INFO - TEST-INFO | started process 5943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4ouOX/profile http://localhost:39673/getInfo.html) 06:56:35 INFO - PROCESS | 5943 | __metrics Screen width/height:1600/1200 06:56:35 INFO - PROCESS | 5943 | colorDepth:24 06:56:35 INFO - PROCESS | 5943 | Browser inner width/height: 1024/697 06:56:35 INFO - PROCESS | 5943 | __metrics 06:56:35 INFO - PROCESS | 5943 | 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:56:35 INFO - PROCESS | 5943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:36 INFO - PROCESS | 5943 | console.error: PushService: 06:56:36 INFO - PROCESS | 5943 | stateChangeProcessEnqueue: Error transitioning state 06:56:36 INFO - PROCESS | 5943 | UnknownError 06:56:37 INFO - TEST-INFO | 5943: exit 0 06:56:37 INFO - Browser initialized. 06:56:37 INFO - Running cycle 1/1 for kraken test... 06:56:37 INFO - TEST-INFO | started process 6025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4ouOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:49 INFO - PROCESS | 6025 | RSS: Main: 175435776 06:56:49 INFO - PROCESS | 6025 | 06:56:52 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39673/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:53 INFO - PROCESS | 6025 | RSS: Main: 233832448 06:56:53 INFO - PROCESS | 6025 | 06:56:55 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39673/tests/kraken/driver.html?testName=audio-dft) 06:56:56 INFO - PROCESS | 6025 | RSS: Main: 218980352 06:56:56 INFO - PROCESS | 6025 | 06:56:59 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39673/tests/kraken/driver.html?testName=audio-fft) 06:57:00 INFO - PROCESS | 6025 | RSS: Main: 300122112 06:57:00 INFO - PROCESS | 6025 | 06:57:02 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39673/tests/kraken/driver.html?testName=audio-oscillator) 06:57:03 INFO - PROCESS | 6025 | RSS: Main: 210178048 06:57:03 INFO - PROCESS | 6025 | 06:57:05 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39673/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:05 INFO - PROCESS | 6025 | RSS: Main: 214081536 06:57:05 INFO - PROCESS | 6025 | 06:57:09 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39673/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:09 INFO - PROCESS | 6025 | RSS: Main: 250269696 06:57:09 INFO - PROCESS | 6025 | 06:57:13 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39673/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:13 INFO - PROCESS | 6025 | RSS: Main: 244731904 06:57:13 INFO - PROCESS | 6025 | 06:57:16 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39673/tests/kraken/driver.html?testName=json-parse-financial) 06:57:17 INFO - PROCESS | 6025 | RSS: Main: 247685120 06:57:17 INFO - PROCESS | 6025 | 06:57:19 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39673/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:19 INFO - PROCESS | 6025 | RSS: Main: 211222528 06:57:19 INFO - PROCESS | 6025 | 06:57:21 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:22 INFO - PROCESS | 6025 | RSS: Main: 218521600 06:57:22 INFO - PROCESS | 6025 | 06:57:24 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:25 INFO - PROCESS | 6025 | RSS: Main: 222838784 06:57:25 INFO - PROCESS | 6025 | 06:57:28 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:28 INFO - PROCESS | 6025 | RSS: Main: 224071680 06:57:28 INFO - PROCESS | 6025 | 06:57:31 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:32 INFO - PROCESS | 6025 | RSS: Main: 221655040 06:57:32 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | Cycle 1(1): loaded http://localhost:39673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39673/tests/kraken/driver.html?testName=ai-astar) 06:57:34 INFO - PROCESS | 6025 | RSS: Main: 272330752 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | __start_tp_report 06:57:34 INFO - PROCESS | 6025 | _x_x_mozilla_page_load 06:57:34 INFO - PROCESS | 6025 | _x_x_mozilla_page_load_details 06:57:34 INFO - PROCESS | 6025 | |i|pagename|runs| 06:57:34 INFO - PROCESS | 6025 | |0;ai-astar;112;116;115;116;118;114;115;117;114;117 06:57:34 INFO - PROCESS | 6025 | |1;audio-beat-detection;163;123;126;170;128;125;130;129;159;123 06:57:34 INFO - PROCESS | 6025 | |2;audio-dft;161;161;161;162;161;162;160;162;162;162 06:57:34 INFO - PROCESS | 6025 | |3;audio-fft;76;77;76;116;77;77;78;75;107;77 06:57:34 INFO - PROCESS | 6025 | |4;audio-oscillator;84;83;117;85;84;83;103;85;85;121 06:57:34 INFO - PROCESS | 6025 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 06:57:34 INFO - PROCESS | 6025 | |6;imaging-darkroom;148;147;146;147;148;146;146;147;147;146 06:57:34 INFO - PROCESS | 6025 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;95;95 06:57:34 INFO - PROCESS | 6025 | |8;json-parse-financial;68;66;67;65;65;72;64;65;64;65 06:57:34 INFO - PROCESS | 6025 | |9;json-stringify-tinderbox;66;67;67;67;67;67;67;66;67;68 06:57:34 INFO - PROCESS | 6025 | |10;stanford-crypto-aes;82;83;85;88;81;82;81;82;82;83 06:57:34 INFO - PROCESS | 6025 | |11;stanford-crypto-ccm;139;154;136;135;138;135;137;145;182;137 06:57:34 INFO - PROCESS | 6025 | |12;stanford-crypto-pbkdf2;176;178;176;176;172;176;177;178;179;176 06:57:34 INFO - PROCESS | 6025 | |13;stanford-crypto-sha256-iterative;74;73;74;70;70;70;69;72;69;69 06:57:34 INFO - PROCESS | 6025 | __end_tp_report 06:57:34 INFO - PROCESS | 6025 | __start_cc_report 06:57:34 INFO - PROCESS | 6025 | _x_x_mozilla_cycle_collect,1938 06:57:34 INFO - PROCESS | 6025 | __end_cc_report 06:57:34 INFO - PROCESS | 6025 | __startTimestamp1474898254380__endTimestamp 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | ------- Summary: start ------- 06:57:34 INFO - PROCESS | 6025 | Number of tests: 14 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.78 (1.5%) stddev-sans-first:1.39 06:57:34 INFO - PROCESS | 6025 | Values: 112.0 116.0 115.0 116.0 118.0 114.0 115.0 117.0 114.0 117.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:129.50 stddev:18.55 (14.3%) stddev-sans-first:17.25 06:57:34 INFO - PROCESS | 6025 | Values: 163.0 123.0 126.0 170.0 128.0 125.0 130.0 129.0 159.0 123.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 06:57:34 INFO - PROCESS | 6025 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 160.0 162.0 162.0 162.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:14.88 (19.3%) stddev-sans-first:15.53 06:57:34 INFO - PROCESS | 6025 | Values: 76.0 77.0 76.0 116.0 77.0 77.0 78.0 75.0 107.0 77.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:84.00 stddev:14.96 (17.8%) stddev-sans-first:15.51 06:57:34 INFO - PROCESS | 6025 | Values: 84.0 83.0 117.0 85.0 84.0 83.0 103.0 85.0 85.0 121.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:57:34 INFO - PROCESS | 6025 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 06:57:34 INFO - PROCESS | 6025 | Values: 148.0 147.0 146.0 147.0 148.0 146.0 146.0 147.0 147.0 146.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:57:34 INFO - PROCESS | 6025 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.50 stddev:2.42 (3.7%) stddev-sans-first:2.47 06:57:34 INFO - PROCESS | 6025 | Values: 68.0 66.0 67.0 65.0 65.0 72.0 64.0 65.0 64.0 65.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 06:57:34 INFO - PROCESS | 6025 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 68.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.13 (2.6%) stddev-sans-first:2.24 06:57:34 INFO - PROCESS | 6025 | Values: 82.0 83.0 85.0 88.0 81.0 82.0 81.0 82.0 82.0 83.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:138.50 stddev:14.64 (10.6%) stddev-sans-first:15.43 06:57:34 INFO - PROCESS | 6025 | Values: 139.0 154.0 136.0 135.0 138.0 135.0 137.0 145.0 182.0 137.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:176.50 stddev:1.90 (1.1%) stddev-sans-first:2.01 06:57:34 INFO - PROCESS | 6025 | Values: 176.0 178.0 176.0 176.0 172.0 176.0 177.0 178.0 179.0 176.0 06:57:34 INFO - PROCESS | 6025 | 06:57:34 INFO - PROCESS | 6025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.05 (2.9%) stddev-sans-first:1.87 06:57:34 INFO - PROCESS | 6025 | Values: 74.0 73.0 74.0 70.0 70.0 70.0 69.0 72.0 69.0 69.0 06:57:34 INFO - PROCESS | 6025 | -------- Summary: end -------- 06:57:34 INFO - PROCESS | 6025 | 06:57:35 INFO - TEST-INFO | 6025: exit 0 06:57:35 INFO - TEST-OK | kraken | took 65697ms 06:57:35 INFO - SUITE-END | took 1187s 06:57:36 INFO - Completed test suite (00:19:47) 06:57:36 INFO - javascript benchmark 06:57:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.59062549992, 2582.75463830936, 2625.4880298341827, 2633.157389635316, 2634.4599357131788, 4475.507694153641, 4554.658400619958, 4679.602233810126, 4696.483386827451, 4709.976450117753, 4590.701604395712, 4624.2370008948565, 4655.4413470383515, 4686.390769199999, 4744.881377965544, 4268.338407546835, 4295.312749960007, 4307.504636966758, 4327.502337231212, 4347.760873151976, 4321.9783901080455, 4400.939236919549, 4402.845900393487, 4406.97796511017, 4416.205083085043, 4186.602272784081, 4348.1086377292895, 4355.847545335898, 4369.803358848843, 4463.375127482139, 4224.112936283384, 4265.552117027699, 4283.614474697292, 4302.376155457441, 4345.239583072949, 4300.462442194726, 4301.892452688677, 4304.0, 4362.083962367907, 4367.737935723867, 4698.7650617469335, 4703.6237101032175, 4720.834770783006, 4721.457032441279, 4733.313669517901, 4849.418069831608, 4906.215005599122, 4947.925781113287, 5004.624653150991, 5029.673071250357, 5018.4981501849525, 5022.196448568212, 5022.84931452057, 5053.8231161909525, 5069.467705890866, 4664.346991421204, 4672.789724462339, 4672.789724462339, 4676.672632915731, 4732.290156476487, 4969.552740253323, 4998.925016124761, 5034.521720436626, 5118.334616499831, 5178.974105129526, 4805.495422980606, 4808.807647694123, 4813.0, 4874.025194961022, 4883.926741098886, 4875.463698993108, 4879.365682461257, 4882.536159064884, 4883.389576302962, 4950.950490495049, 4772.665913386029, 4825.0, 4841.080194762983, 4846.055019271208, 4921.335619691367, 4931.876703082452, 4967.627427942919, 4989.027139707722, 5045.722485263345, 5050.217216331474, 4282.314829627245, 4282.978585107055, 4301.483821941387, 4331.97834010828, 4339.0, 3708.4437334399518, 3743.1577894973957, 3747.868824591126, 3775.9433608495897, 3797.5442946846556, 4192.895177620584, 4239.04621460169, 4243.724157929724, 4329.112531930947, 4386.18855511725, 4940.283658869444, 4950.8267210647455, 4954.801807927714, 4963.329950456642, 4965.751712414365, 4269.5090064642345, 4273.87178384649, 4316.050468896838, 4321.308590625485, 4370.475542934868, 4543.636509079266, 4546.272596384629, 4588.770561471913, 4593.931091033637, 4599.310103484504, 4721.126591580569, 4750.311204875274, 4753.049390122059, 4756.833510827174, 4812.5668689818085, 4850.320955066223, 4931.0, 4951.777170027285, 4971.105201063843, 5023.623228257969, 4728.692634978715, 4731.243001119804, 4744.264638980963, 4797.616190704805, 4822.348982887265, 4935.037667654773, 4942.604591632589, 4947.628927830499, 4969.577585905238, 5006.62450316235, 4793.9041219176115, 4888.780004899859, 5013.924791128063, 5031.446540880451, 5081.339425874613, 4832.516748325139, 4858.295547145714, 4884.1941079722865, 4896.559309662148, 4955.925661115014, 4862.0, 4885.926711099265, 4887.731174785279, 4912.0, 4951.084049450863, 4655.3249778782565, 4714.811407543797, 4840.201366774443, 4847.103285892122, 4893.877653058702, 4887.804487820589, 4927.137750893651, 4959.0329885671945, 4961.677490963076, 5019.874503137451, 4844.346013288302, 4853.320535125014, 4860.708357498562, 4866.852612303246, 4901.950980490149], "value": 4592.406004253765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5742207211483, 573.0401577357926, 576.0955300178719, 577.312997532936, 585.6515373352854, 30535.236619084535, 31359.0, 31422.84288578557, 31469.68530314696, 31479.0, 31296.687033129663, 39061.0, 40608.0, 40614.39078413826, 44305.77847110768, 7546.2831031051965, 7697.0378702662165, 7705.422093342993, 7707.30634242918, 7710.113336966237, 7591.278828511283, 7681.57751323677, 7686.961565192194, 7688.807779805494, 7690.846183076335, 7674.769756907302, 7716.074071111474, 7718.189590093044, 7719.691212351528, 7722.652480638385, 7639.04511936008, 7690.15408305086, 7704.537727736354, 7704.6532906019365, 7710.7686769397005, 7561.659725312319, 7639.847203055963, 7641.808954776119, 7643.617819109078, 7644.044494438195, 36391.818040909624, 36693.0, 36767.63232367669, 36802.0, 36806.26387472262, 2926.2391778137626, 3044.2237229506336, 3290.7696461247483, 3300.488424294238, 3617.4935509028755, 26234.86882565575, 28539.57190642142, 28857.278568035756, 28974.565381519293, 28982.565261521093, 3445.5693038370205, 3502.2995400919917, 3607.837647305851, 3655.817209139532, 3658.3414985302634, 252228.0, 252964.0, 255003.0, 255107.72446137836, 256361.0, 30934.81303739261, 54059.0, 54608.0, 54636.72681636566, 54644.25691889279, 31197.376052478823, 33733.325333493194, 33740.0, 33751.0, 33755.32489350248, 12840.807387889003, 12845.807312890314, 13059.869401306056, 13061.542846000344, 13069.0, 10303.639372621923, 10465.84301235482, 10515.211359148094, 10532.05211530966, 10561.841572376421, 7716.4212684048925, 7747.38020958322, 7775.079821438343, 7809.414293927978, 7854.607269636495, 3004.23392035034, 3038.2252525605827, 3052.8168309901475, 3065.9540106898417, 3066.494028485275, 808.8584497712877, 817.9141190175066, 853.7865533616596, 873.8296032273772, 944.560779237644, 25323.87338063298, 27395.315117121834, 27617.0, 27785.44429111447, 28041.43917121687, 778.7118766056595, 912.7444315591645, 918.5315489100607, 948.6300342866288, 948.8861336639509, 13830.74259120514, 14909.850901491063, 15062.548123556311, 15153.166575838435, 15167.696646067017, 361084.0, 361201.0, 361261.0, 362490.0, 364770.0, 47474.762626186646, 47870.5212947873, 47908.28137577939, 47919.76040119777, 48378.516214838106, 1048.0933992096782, 1097.9451027448595, 1103.0734183286079, 1163.5229555882047, 1182.781185480689, 23076.538469230858, 28543.857280714295, 29502.787290952834, 31289.8435507821, 31302.686973129978, 46472.30291545562, 47325.52674473211, 47388.7630561845, 47411.28883066826, 47445.52554474549, 306204.0, 306730.0, 306923.0, 307052.0, 307222.0, 24330.75669243285, 25064.248072557853, 25113.87443062773, 25402.237932862045, 25505.74494255108, 41018.0, 41046.79476602598, 41139.7943010295, 41140.58859411367, 41407.792961035004, 34832.82583587066, 34856.47715284323, 34937.0, 34983.300333992665, 35154.64845351616, 32789.0, 34677.47983780296, 34925.47611785775, 34926.30147397089, 35017.649823502456, 29440.852795735886, 29945.101646950625, 35294.11764705903, 35422.822885885405, 35781.46327805137, 29071.7092829069, 30959.226019349695, 31475.84262078675, 31793.841030794698, 32000.0, 24877.38787427294, 25002.0, 25040.248792536255, 25161.622575661746, 25459.87270063712], "value": 16049.048660506569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.82728290420596, 367.22515492311226, 370.21329674441813, 380.950476438063, 383.9731218814684, 15563.377464901405, 16670.749938750912, 16967.915160424196, 17213.91393043036, 17267.91366043168, 16348.918255408706, 17059.0, 17067.658646827054, 17213.13934303286, 17228.655426891455, 4723.881902952419, 4970.229614409773, 4977.527134922195, 4978.800847966077, 4983.127952608297, 3689.594144644087, 3879.4180872869156, 4994.87512812179, 5574.609777315569, 5825.446582574648, 5904.439078287556, 5904.734286957076, 5906.2912450506, 5912.231409916705, 5950.315713692916, 5691.4877661010505, 5921.73352199152, 5953.910691339634, 5970.761169553212, 5974.312954010301, 5103.795848166069, 5266.578673706094, 5267.236250743659, 5268.5521730652945, 5269.262303277545, 20148.597028059503, 20254.79745202544, 20286.69569956452, 20586.382408527767, 20606.175752969863, 1834.1562881074722, 1891.8202770736757, 2046.8567200295986, 2189.4745261137373, 2382.0114652419225, 12505.249685018927, 12975.0, 13548.390322435514, 13672.453101875913, 13706.314684265746, 1647.5057482755246, 1650.207900207907, 1720.9913950430168, 1753.0883940350946, 1834.1929550997518, 63887.0, 65818.67090664516, 66570.66714666395, 67354.32645673529, 68492.31507684909, 9253.0, 9411.717648470556, 9590.712278631652, 9732.0, 9933.205343572497, 13335.733285334432, 13360.064795464225, 13381.330933453288, 13382.866171338163, 13388.129771564818, 6914.446844252448, 7038.5073044887395, 7098.822529436702, 7151.53515021522, 7162.140543134858, 6550.7573750992615, 6653.800385988428, 6828.487863410264, 6841.657917104125, 6861.279565645636, 6133.325334213233, 6220.782272620437, 6249.062640603855, 6251.3123556408755, 6414.61512309263, 1658.8507034366723, 1696.9321227151022, 1745.0, 1779.17268470162, 1791.6774980503635, 855.4696088425217, 869.6130222051253, 877.3113106211721, 877.3551439691821, 891.1623074310128, 16718.0, 16859.24133413999, 17603.911980440014, 17679.823201768075, 18037.0, 802.5425507460808, 813.2680587471323, 853.1894700034992, 883.7481317824389, 948.3266880514911, 9690.321677482649, 10221.43782091992, 10267.486625668687, 10274.721707559394, 10362.740931476774, 324868.0, 325799.0, 326181.0, 326358.0, 339358.0, 41258.0, 50352.181324641344, 64727.67636161789, 65020.34979650238, 68072.65963670249, 789.8420315936836, 806.2944923192324, 844.6663567890772, 866.3242670716851, 867.6355930509075, 15089.773653395427, 15639.0, 16315.18424078815, 16337.509874703777, 16499.83500165031, 32436.0, 33708.49437258492, 33725.3254934895, 34318.65681343254, 34721.826390867885, 41792.79103604584, 42614.08236629297, 43436.56563434325, 43800.0, 44747.77626111849, 4769.880752981203, 4996.150654388835, 6917.757878474229, 7550.942867998375, 7836.177201394, 11109.722256943318, 11512.481938312963, 11764.411779411166, 11839.644810655695, 12254.080943929062, 9686.612535498502, 10185.49072546355, 10425.426601536685, 10428.791424171626, 10681.19891008193, 9908.207343412654, 10066.245031622804, 10132.290739648153, 10185.79628407413, 10503.369797812156, 10303.278770486293, 10321.277510574188, 10762.946185269024, 10814.945925270324, 10981.0, 7642.0, 7717.305442510201, 7879.0, 7882.960585197037, 7915.762527124196, 10146.086852183338, 10432.895671043192, 10488.475576221006, 10528.578856845947, 10831.24181307301], "value": 8158.010118296263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.6057552446505, 1352.0265408905589, 1362.960597866757, 1606.6063814365482, 1646.4566692991314, 6422.646754428516, 6693.129893113888, 7031.296870312966, 7582.2038685938005, 7583.203763604824, 7164.570125792443, 7412.703491860332, 7442.590657513834, 7660.885086723703, 7664.11862635797, 2100.9159633614636, 2128.531723020933, 2131.9040643171015, 2134.743830740313, 2135.0819147766456, 1822.4259358302158, 1891.6216756648657, 2075.2425364741835, 2091.4771307173205, 2139.70044193813, 1905.3236101184089, 1920.0591710062108, 1925.1048262557908, 2053.5276886316155, 2131.6269652810774, 2037.1749441476227, 2039.4391542325832, 2041.8162365387038, 2042.4893776555862, 2042.4893776555862, 2047.1811275489922, 2055.599158164159, 2072.927447539329, 2106.241752968945, 2108.599366120432, 7603.695852165962, 7699.653515591812, 7753.844923101563, 7755.573443460607, 7777.961110194469, 4439.2675208590545, 4552.544745525454, 4553.567411095941, 4556.954430455686, 4560.977195114003, 2849.5298275784676, 2889.0, 2938.603288556039, 2960.1119664100897, 2968.139239620529, 886.5478605910968, 904.4482865452069, 917.312015988009, 930.6417029443645, 931.5109567477128, 10342.172626189888, 10387.11709504693, 10398.896011039868, 10402.843957340647, 10405.687829365132, 3995.820188091543, 4004.4794176756836, 4205.705600607928, 4236.661067114624, 4250.42619246404, 8982.640694372283, 9008.909910900938, 9017.413868098552, 9018.549072546477, 9022.097790220925, 4666.719996800203, 4689.366935463669, 4691.413573303337, 4691.413573303337, 4699.412573428322, 4192.392103145027, 4281.571842815693, 4283.2932566126865, 4286.6999310047995, 4287.249731297073, 3512.8243587820507, 3596.6403359664346, 3616.9638303617153, 3790.753601015925, 3792.6965842732516, 1099.8075336816025, 1102.8731695855079, 1128.5260190719916, 1143.0912424622445, 1153.7692461507731, 654.4044919123575, 800.1118758178417, 801.9238172373615, 804.9393552505487, 821.2280456370992, 5148.0, 5204.0372531081875, 5272.7100009499845, 5277.656952298088, 5319.228711836762, 409.78281510799326, 412.51117425850464, 413.83032956488296, 414.13652534465376, 416.0223474834116, 3572.2676851245433, 3579.51676523666, 3662.322470342995, 3677.669009789132, 3984.442178095069, 9019.143181397756, 9215.585298661576, 9287.442753434816, 9321.207697345802, 9323.160915517636, 9270.44377337362, 9282.675106371245, 9284.95357523208, 9289.256859451227, 9297.070292970784, 6997.195322537973, 7274.890876636855, 7282.053333066668, 7284.49008569395, 7290.125184977836, 5126.9743651283, 5178.404483484447, 5201.297824793604, 5212.661177023481, 5349.518543331119, 8492.532910689724, 8526.104759000216, 8716.694915677921, 8778.07521221216, 8868.645254190018, 8715.869261960948, 8979.46123232608, 9005.324600654845, 9061.048589897966, 9072.95463522678, 6283.497320214463, 6390.265119511316, 6444.226692796894, 6445.581037232565, 6458.967705161444, 7038.155421349471, 7086.39765619928, 7147.571145731273, 7148.213696493485, 7148.499605027599, 6347.619142851444, 6416.454601358937, 6484.319146489739, 6502.739890404331, 6505.0, 6538.1827271591055, 6541.6402097883165, 6546.770863019771, 6563.409293163638, 6580.703868325841, 5993.730282137227, 5995.46040856325, 6005.309389420097, 6051.939480605138, 6063.333033366414, 4269.359596060492, 4302.978485107555, 4313.180495705806, 4376.781160942004, 4496.7077139985795, 4263.850765223202, 4294.227039132986, 4297.076128632234, 4500.842470513517, 4518.277075667877], "value": 3944.029805336682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.6059404754179, 290.6686377529615, 295.63932002956386, 300.6032037710222, 305.5599936092027, 4584.4040274764275, 4718.598919091877, 4835.1296766582, 4852.902941941159, 4870.464248932614, 4719.292106184074, 4813.446453657831, 4826.806927722887, 4826.831060912868, 4836.903261934768, 3802.448644946481, 3821.5414150302004, 3824.3689791184493, 3836.462895194675, 3853.3834586466173, 3585.94621080684, 3662.963370366302, 3696.7431073435027, 3815.9046023849346, 3818.4081467372603, 3740.9438858417147, 3741.5323084614424, 3742.719296052793, 3749.343864823659, 3752.924941501168, 3726.944095838551, 3733.272011957683, 3764.0589852536864, 3768.660820526138, 3777.5655799583124, 3343.866245350183, 3352.5306457096026, 3356.446186379269, 3358.748093892968, 3374.5950485941844, 4506.774661266923, 4548.2268014437295, 4577.56513131252, 4580.312953057035, 4580.335851301543, 4243.851465198734, 4249.447571815645, 4259.148170365939, 4268.9573104268875, 4273.18809426208, 4898.0, 4922.360093187863, 4928.349003083971, 4929.186684197139, 4957.82647607332, 3361.4201325377035, 3543.982280088583, 3544.7518673692853, 3612.187257866959, 3614.34941710492, 5167.405748338914, 5188.299579556749, 5188.870278243036, 5205.531502164823, 5206.0, 3638.8544458221904, 3642.1440961374055, 3644.2164934538673, 3648.3980143276062, 3656.2687462507074, 3678.779273243614, 3704.9259014819554, 3712.461693054546, 3730.1047748540695, 3739.551253849501, 3995.9400608990886, 4023.2355852387955, 4066.3290557057753, 4110.547839737626, 4248.426462427533, 5003.524665156804, 5007.973365460072, 5010.3737032870895, 5012.298278241049, 5013.3983921928875, 1264.6332563556466, 1279.6992706713916, 1281.9744204636254, 1284.1332100832087, 1288.67138879587, 793.15132807895, 817.2644619842071, 820.4134044158455, 829.4732844643695, 835.3734698975768, 3956.940645890314, 3960.0, 3968.948228719334, 3969.4442778011103, 3975.3241948868763, 4503.639708823286, 4507.323901414748, 4509.6392288616835, 4518.774061296922, 4526.411566496335, 3967.3535482774323, 3976.8011599419915, 3988.823297127354, 3989.7606143631474, 4002.939955900664, 2313.4679023824615, 2394.916177933764, 2413.951720965571, 2423.6122220444645, 2428.599281118631, 4290.678199135077, 4298.441202643637, 4313.266744653416, 4330.523642399334, 4334.0, 4581.625512346282, 4594.977025114853, 4605.3387556891685, 4608.400907881954, 4647.233206520954, 4106.609872062149, 4293.96944733268, 4298.903779536198, 4308.655307575386, 4315.870523884351, 4449.19807477972, 4449.688521803443, 4467.530909254611, 4473.418455600751, 4508.774561271857, 4409.625181859577, 4429.623482004065, 4441.7779111044965, 4469.620082293041, 4490.236659767782, 4133.81397837092, 4293.82824687009, 4306.956930430656, 4328.112736888867, 4363.214621368184, 3269.2807582331848, 3280.835958202128, 3293.884714034997, 3300.9601975377677, 3330.1841048943165, 4485.600203890903, 4529.8641040768825, 4584.744831169906, 4868.488808675038, 5033.622478314214, 4934.65603838174, 5013.323201367914, 5020.598352131894, 5028.84913452597, 5081.568066714222, 4905.950940490549, 4995.625328100335, 5006.823396501892, 5008.348914641073, 5021.196608542616, 4735.881602959816, 4834.71879951806, 4894.877628059185, 4931.211006238985, 4953.578945789648, 4969.0807200668, 4969.900601987868, 4970.279309500174, 4972.5276098770555, 5003.824866129668, 4877.146499362527, 4879.536444037811, 4917.188663870421, 4930.950690493192, 4944.703317800943], "value": 3621.331435414267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.7559665125578, 716.5485743981291, 723.9611157988287, 739.5230076600593, 745.6719043620803, 13534.796978045324, 14480.855191448083, 14621.561353159395, 14659.19374434407, 14665.12009279444, 13346.466141354358, 13367.331633418338, 13370.66573335667, 13377.39801708923, 13381.464741410331, 630.7413960276288, 744.5346658338525, 745.9738909138181, 769.9961500192519, 775.3796962430062, 771.6836097200149, 779.976600701977, 786.8937693411402, 788.771256335662, 789.960501974899, 828.9461185022984, 830.9542975136366, 831.55096248026, 831.6257684042175, 831.683960095163, 825.2078005115096, 825.628467189764, 826.5454000299871, 833.9916600834035, 834.7287131682167, 609.7621927448299, 609.9481544068759, 610.9847253818646, 611.4313688269951, 611.5352332227494, 12468.501259949591, 12494.937525312405, 12523.373831308398, 12540.122191446602, 12540.435680394405, 13657.453701852013, 13785.448582056706, 13813.585592432242, 14073.141731382542, 14313.71372572553, 10704.0, 10729.141668666489, 10793.67618971432, 11043.0, 11048.171387145916, 3271.5910511186103, 3313.7680362374645, 3316.519104729825, 3319.7012268895674, 3396.490526421032, 38437.61562384368, 59329.70335148297, 59524.10713839339, 64684.67657661728, 65948.6702566489, 9148.2681385489, 9349.672761453316, 9579.425234485952, 9682.225421966226, 10619.84070238947, 18423.170957306953, 18673.439796806117, 18681.532961675795, 18706.0, 18709.906450467934, 6562.442192413603, 6703.363180497845, 6798.490113241428, 6917.550359226634, 7090.822729431806, 3629.4737263096704, 3666.50502182202, 3693.6306369362846, 3711.536057992751, 3800.0309920969976, 2807.4385122975486, 2932.706729327093, 2934.60382848317, 2935.0314396249614, 2939.103573410088, 492.73884841033595, 493.3019777015483, 500.2721040885503, 509.9774951222849, 513.5686023740002, 482.8310091467958, 483.9733814640158, 524.219121610911, 526.8709166254216, 548.7064420535074, 7422.851542969111, 7532.246775322424, 7537.585432801248, 7556.4710470266555, 7760.417968652374, 442.3652059294922, 463.6777439679458, 472.21847841821153, 479.62828807674333, 534.3134072716541, 3696.6857817085847, 3819.1406933440308, 3841.980790096032, 3844.6347596978803, 3860.2665493556133, 96565.0, 97313.0, 98813.0, 102332.0, 102445.48777256066, 85682.57158714166, 85989.71015434773, 87046.56476717576, 87764.56117719371, 88348.0, 75212.62393688106, 75420.0, 75611.08527945666, 76499.23500764921, 77277.6136119327, 6909.170899492093, 7137.214906360193, 7174.569525828467, 7179.282071792779, 7206.819829504304, 43837.34243986406, 44422.999999998705, 45178.0, 45277.54722452865, 45799.77100114478, 64655.35344646681, 65104.34895650983, 65543.34456655373, 67079.32920670926, 70874.64562677154, 7797.883031754414, 8295.751127466187, 8396.706115285935, 8606.354523410644, 8641.265492433213, 9252.861207081765, 9319.953400232955, 9409.717708468757, 9968.202543796624, 10297.74255643615, 8617.426594407694, 8674.436161649473, 8796.692115775917, 8872.86690699627, 8932.46405215689, 9283.907160928304, 9359.391639543408, 9464.810703786023, 9759.170470510086, 9883.159931405911, 8376.83246335082, 8534.402591818513, 8711.69509067205, 8749.825003499767, 8894.555272236492, 8042.95978520127, 8251.512744025396, 8337.124601916954, 8378.45879202628, 8468.872966905625, 7487.925120748941, 7656.119546252252, 7672.539647621161, 7788.299053085249, 7832.530048197126], "value": 6180.387886421756, "unit": "score"}], "name": "dromaeo_css", "value": 6130.435841024035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 116.0, 118.0, 114.0, 115.0, 117.0, 114.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 123.0, 126.0, 170.0, 128.0, 125.0, 130.0, 129.0, 159.0, 123.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 116.0, 77.0, 77.0, 78.0, 75.0, 107.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 85.0, 84.0, 83.0, 103.0, 85.0, 85.0, 121.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 65.0, 65.0, 72.0, 64.0, 65.0, 64.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 85.0, 88.0, 81.0, 82.0, 81.0, 82.0, 82.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 154.0, 136.0, 135.0, 138.0, 135.0, 137.0, 145.0, 182.0, 137.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 176.0, 176.0, 172.0, 176.0, 177.0, 178.0, 179.0, 176.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 70.0, 70.0, 70.0, 69.0, 72.0, 69.0, 69.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1556.9, "alertThreshold": 2.0}]} 06:57:36 INFO - Return code: 0 06:57:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:57:36 INFO - # TBPL SUCCESS # 06:57:36 INFO - Running post-action listener: _resource_record_post_action 06:57:36 INFO - [mozharness: 2016-09-26 13:57:36.207020Z] Finished run-tests step (success) 06:57:36 INFO - Running post-run listener: _resource_record_post_run 06:57:36 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 425984; Write bytes: 399785984; Read time: 312; Write time: 448504 06:57:36 INFO - TinderboxPrint: CPU usage
13.1% 06:57:36 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 312 06:57:36 INFO - TinderboxPrint: I/O write bytes / time
399,785,984 / 448,504 06:57:36 INFO - TinderboxPrint: CPU idle
8,346.4 (86.9%) 06:57:36 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 06:57:36 INFO - TinderboxPrint: Swap in / out
0 / 0 06:57:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99905536; Read time: 0; Write time: 169880 06:57:36 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 425984; Write bytes: 288493568; Read time: 312; Write time: 276248 06:57:36 INFO - Running post-run listener: _upload_blobber_files 06:57:36 INFO - Blob upload gear active. 06:57:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:36 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:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:41 INFO - (blobuploader) - INFO - Done attempting. 06:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:42 INFO - (blobuploader) - INFO - Done attempting. 06:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:42 INFO - (blobuploader) - INFO - Done attempting. 06:57:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:42 INFO - Return code: 0 06:57:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1f6b2d57eaadd21620351096dbbb720876cc27f4e7fc716fa7218ab4c72a53e322698d248d76b2e7aa56a7f602eaa0a8de05325736a55787658f1476964fe24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f91432ab2a946fb3f00b0e2ccd77cfbd3a461dd86c28944aab07cf8ae087b456fab27b03a5d2caf06016a7865a9bb8918540de7de73eaf5fe84d159beaf2aca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffa47d4cbef50a38a2eb44e6ec5fb6a2dbd4c8a6c60caa357d15a7b1fd94e70246785cf48adc7dd5e3b58d1c05286858897684ab6f0739a83f9104b82e0d4b60"} 06:57:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:42 INFO - Contents: 06:57:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1f6b2d57eaadd21620351096dbbb720876cc27f4e7fc716fa7218ab4c72a53e322698d248d76b2e7aa56a7f602eaa0a8de05325736a55787658f1476964fe24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f91432ab2a946fb3f00b0e2ccd77cfbd3a461dd86c28944aab07cf8ae087b456fab27b03a5d2caf06016a7865a9bb8918540de7de73eaf5fe84d159beaf2aca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffa47d4cbef50a38a2eb44e6ec5fb6a2dbd4c8a6c60caa357d15a7b1fd94e70246785cf48adc7dd5e3b58d1c05286858897684ab6f0739a83f9104b82e0d4b60"} 06:57:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:42 INFO - Copying logs to upload dir... 06:57:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.607839 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-26 06:57:42.919965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 06:57:42.923032) ========= 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=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1f6b2d57eaadd21620351096dbbb720876cc27f4e7fc716fa7218ab4c72a53e322698d248d76b2e7aa56a7f602eaa0a8de05325736a55787658f1476964fe24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f91432ab2a946fb3f00b0e2ccd77cfbd3a461dd86c28944aab07cf8ae087b456fab27b03a5d2caf06016a7865a9bb8918540de7de73eaf5fe84d159beaf2aca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffa47d4cbef50a38a2eb44e6ec5fb6a2dbd4c8a6c60caa357d15a7b1fd94e70246785cf48adc7dd5e3b58d1c05286858897684ab6f0739a83f9104b82e0d4b60"} build_url:https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1f6b2d57eaadd21620351096dbbb720876cc27f4e7fc716fa7218ab4c72a53e322698d248d76b2e7aa56a7f602eaa0a8de05325736a55787658f1476964fe24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f91432ab2a946fb3f00b0e2ccd77cfbd3a461dd86c28944aab07cf8ae087b456fab27b03a5d2caf06016a7865a9bb8918540de7de73eaf5fe84d159beaf2aca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffa47d4cbef50a38a2eb44e6ec5fb6a2dbd4c8a6c60caa357d15a7b1fd94e70246785cf48adc7dd5e3b58d1c05286858897684ab6f0739a83f9104b82e0d4b60"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 06:57:42.947881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:57:42.948179) ========= 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=745a4373a2a16df560f216e000000264-1474896705.325651-238013076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:57:43.032549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 06:57:43.032883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 06:57:43.033163) ========= ========= Total master_lag: 0.16 =========