builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1474984002.6 results: success (0) buildid: 20160927033005 builduid: 07e8bb2653b746f7ae44fd3acb87bb6b revision: 93bc88233717f6bc59806810664c5c1256e7e367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.596327) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.596808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.597119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.612233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.612533) ========= 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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 06:46:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-09-27 06:46:43 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.715762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.716680) ========= 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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017557 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:42.768464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:46:42.769207) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 93bc88233717f6bc59806810664c5c1256e7e367 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 93bc88233717f6bc59806810664c5c1256e7e367 --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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 06:46:43,718 truncating revision to first 12 chars 2016-09-27 06:46:43,719 Setting DEBUG logging. 2016-09-27 06:46:43,719 attempt 1/10 2016-09-27 06:46:43,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/93bc88233717?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 06:46:44,886 unpacking tar archive at: autoland-93bc88233717/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:46:44.339186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:44.340175) ========= script_repo_revision: 93bc88233717f6bc59806810664c5c1256e7e367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:44.341242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:44.341988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:46:44.355098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-09-27 06:46:44.355427) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:46:45 INFO - MultiFileLogger online at 20160927 06:46:45 in /builds/slave/test 06:46:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 06:46:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:46:45 INFO - {'append_to_log': False, 06:46:45 INFO - 'base_work_dir': '/builds/slave/test', 06:46:45 INFO - 'blob_upload_branch': 'Autoland', 06:46:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:46:45 INFO - 'branch': 'Autoland', 06:46:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:45 INFO - 'config_files': ('talos/linux_config.py',), 06:46:45 INFO - 'default_actions': ('clobber', 06:46:45 INFO - 'read-buildbot-config', 06:46:45 INFO - 'download-and-extract', 06:46:45 INFO - 'populate-webroot', 06:46:45 INFO - 'create-virtualenv', 06:46:45 INFO - 'install', 06:46:45 INFO - 'run-tests'), 06:46:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:45 INFO - 'download_minidump_stackwalk': True, 06:46:45 INFO - 'download_symbols': 'ondemand', 06:46:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:45 INFO - 'installer_path': 'installer.exe', 06:46:45 INFO - 'log_level': 'info', 06:46:45 INFO - 'log_name': 'talos', 06:46:45 INFO - 'log_to_console': True, 06:46:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:46:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:46:45 INFO - 'opt_config_files': (), 06:46:45 INFO - 'pip_index': False, 06:46:45 INFO - 'sps_profile': False, 06:46:45 INFO - 'sps_profile_interval': 0, 06:46:45 INFO - 'suite': 'dromaeojs', 06:46:45 INFO - 'system_bits': '32', 06:46:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:45 INFO - 'title': 'talos-linux64-ix-024', 06:46:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:45 INFO - 'use_talos_json': True, 06:46:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:46:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:45 INFO - 'work_dir': 'build'} 06:46:45 INFO - [mozharness: 2016-09-27 13:46:45.402339Z] Running clobber step. 06:46:45 INFO - Running pre-action listener: _resource_record_pre_action 06:46:45 INFO - Running main action method: clobber 06:46:45 INFO - rmtree: /builds/slave/test/build 06:46:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:46:46 INFO - Running post-action listener: _resource_record_post_action 06:46:46 INFO - [mozharness: 2016-09-27 13:46:46.382920Z] Finished clobber step (success) 06:46:46 INFO - [mozharness: 2016-09-27 13:46:46.383021Z] Running read-buildbot-config step. 06:46:46 INFO - Running pre-action listener: _resource_record_pre_action 06:46:46 INFO - Running main action method: read_buildbot_config 06:46:46 INFO - Using buildbot properties: 06:46:46 INFO - { 06:46:46 INFO - "project": "", 06:46:46 INFO - "product": "firefox", 06:46:46 INFO - "script_repo_revision": "production", 06:46:46 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:46:46 INFO - "repository": "", 06:46:46 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 06:46:46 INFO - "buildid": "20160927033005", 06:46:46 INFO - "pgo_build": "True", 06:46:46 INFO - "basedir": "/builds/slave/test", 06:46:46 INFO - "buildnumber": 257, 06:46:46 INFO - "slavename": "talos-linux64-ix-024", 06:46:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:46:46 INFO - "platform": "ubuntu64_hw", 06:46:46 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 06:46:46 INFO - "branch": "autoland", 06:46:46 INFO - "repo_path": "integration/autoland", 06:46:46 INFO - "revision": "93bc88233717f6bc59806810664c5c1256e7e367", 06:46:46 INFO - "stage_platform": "linux64-pgo", 06:46:46 INFO - "builduid": "07e8bb2653b746f7ae44fd3acb87bb6b", 06:46:46 INFO - "slavebuilddir": "test" 06:46:46 INFO - } 06:46:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:46:46 INFO - Running post-action listener: _resource_record_post_action 06:46:46 INFO - [mozharness: 2016-09-27 13:46:46.385493Z] Finished read-buildbot-config step (success) 06:46:46 INFO - [mozharness: 2016-09-27 13:46:46.386039Z] Running download-and-extract step. 06:46:46 INFO - Running pre-action listener: _resource_record_pre_action 06:46:46 INFO - Running main action method: download_and_extract 06:46:46 INFO - mkdir: /builds/slave/test/build/tests 06:46:46 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:46:46 INFO - trying https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:46:46 INFO - Downloading https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/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:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/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:46:46 INFO - Downloaded 1361 bytes. 06:46:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:46:46 INFO - Using the following test package requirements: 06:46:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:46:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:46:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'jsshell-linux-x86_64.zip'], 06:46:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:46:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:46:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:46:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:46:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:46:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:46:47 INFO - Expected file size: 21984058 06:46:51 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:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:46:52 INFO - Expected file size: 21984058 06:46:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:46:57 INFO - Fetch https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:46:57 INFO - Expected file size: 14414057 06:46:58 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:46:58 INFO - trying https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:58 INFO - Downloading https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/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:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/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:46:59 INFO - Downloaded 59739926 bytes. 06:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:59 INFO - mkdir: /builds/slave/test/properties 06:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:46:59 INFO - Contents: 06:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:47:00 INFO - Running post-action listener: _resource_record_post_action 06:47:00 INFO - Running post-action listener: set_extra_try_arguments 06:47:00 INFO - [mozharness: 2016-09-27 13:47:00.173868Z] Finished download-and-extract step (success) 06:47:00 INFO - [mozharness: 2016-09-27 13:47:00.174098Z] Running populate-webroot step. 06:47:00 INFO - Running pre-action listener: _resource_record_pre_action 06:47:00 INFO - Running main action method: populate_webroot 06:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:00 INFO - '--tppagecycles', 06:47:00 INFO - '7'], 06:47:00 INFO - 'tests': ['tsvgm']}}, 06:47:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['damp', 'tps']}, 06:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'tests': ['damp', 'tps']}, 06:47:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['dromaeo_dom']}, 06:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['basic_compositor_video']}, 06:47:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:47:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['a11yr', 06:47:00 INFO - 'ts_paint', 06:47:00 INFO - 'tpaint', 06:47:00 INFO - 'sessionrestore', 06:47:00 INFO - 'sessionrestore_no_auto_restore', 06:47:00 INFO - 'tabpaint']}, 06:47:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['tsvgx', 06:47:00 INFO - 'tsvgr_opacity', 06:47:00 INFO - 'tart', 06:47:00 INFO - 'tscrollx', 06:47:00 INFO - 'cart']}, 06:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:00 INFO - 'tsvgr_opacity', 06:47:00 INFO - 'tart', 06:47:00 INFO - 'tscrollx', 06:47:00 INFO - 'cart']}, 06:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'talos_options': ['--disable-e10s'], 06:47:00 INFO - 'tests': ['tp5o']}, 06:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'tests': ['tp5o']}, 06:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'talos_options': ['--disable-e10s', 06:47:00 INFO - '--xperf_path', 06:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:00 INFO - 'tests': ['tp5n']}, 06:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:00 INFO - 'talos_options': ['--xperf_path', 06:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:00 INFO - 'tests': ['tp5n']}}, 06:47:00 INFO - 'talos.zip': {'path': '', 06:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:00 INFO - Running post-action listener: _resource_record_post_action 06:47:00 INFO - [mozharness: 2016-09-27 13:47:00.192324Z] Finished populate-webroot step (success) 06:47:00 INFO - [mozharness: 2016-09-27 13:47:00.192414Z] Running create-virtualenv step. 06:47:00 INFO - Running pre-action listener: _resource_record_pre_action 06:47:00 INFO - Running main action method: create_virtualenv 06:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:00 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:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:00 INFO - Using real prefix '/usr' 06:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:02 INFO - Installing pip.................done. 06:47:02 INFO - Return code: 0 06:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:47:02 INFO - Reading from file tmpfile_stdout 06:47:02 INFO - Output received: 06:47:02 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:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:02 INFO - Using env: {'DISPLAY': ':0', 06:47:02 INFO - 'HOME': '/home/cltbld', 06:47:02 INFO - 'LANG': 'en_US.UTF-8', 06:47:02 INFO - 'LANGUAGE': 'en_US:en', 06:47:02 INFO - 'LOGNAME': 'cltbld', 06:47:02 INFO - 'MAIL': '/var/mail/cltbld', 06:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:02 INFO - 'MOZ_NO_REMOTE': '1', 06:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:02 INFO - 'NO_EM_RESTART': '1', 06:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:02 INFO - 'PWD': '/builds/slave/test', 06:47:02 INFO - 'SHELL': '/bin/bash', 06:47:02 INFO - 'SHLVL': '1', 06:47:02 INFO - 'TERM': 'linux', 06:47:02 INFO - 'TMOUT': '86400', 06:47:02 INFO - 'USER': 'cltbld', 06:47:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:02 INFO - '_': '/tools/buildbot/bin/python'} 06:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:03 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:47:03 INFO - Cleaning up... 06:47:03 INFO - Return code: 0 06:47:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:47:03 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:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:03 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:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:03 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:03 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:47:03 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:47:03 INFO - Using env: {'DISPLAY': ':0', 06:47:03 INFO - 'HOME': '/home/cltbld', 06:47:03 INFO - 'LANG': 'en_US.UTF-8', 06:47:03 INFO - 'LANGUAGE': 'en_US:en', 06:47:03 INFO - 'LOGNAME': 'cltbld', 06:47:03 INFO - 'MAIL': '/var/mail/cltbld', 06:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:03 INFO - 'MOZ_NO_REMOTE': '1', 06:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:03 INFO - 'NO_EM_RESTART': '1', 06:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:03 INFO - 'PWD': '/builds/slave/test', 06:47:03 INFO - 'SHELL': '/bin/bash', 06:47:03 INFO - 'SHLVL': '1', 06:47:03 INFO - 'TERM': 'linux', 06:47:03 INFO - 'TMOUT': '86400', 06:47:03 INFO - 'USER': 'cltbld', 06:47:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:03 INFO - '_': '/tools/buildbot/bin/python'} 06:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:03 INFO - Downloading/unpacking psutil>=3.1.1 06:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:05 INFO - Installing collected packages: psutil 06:47:05 INFO - Running setup.py install for psutil 06:47:05 INFO - building 'psutil._psutil_linux' extension 06:47:05 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:47:05 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:47:05 INFO - building 'psutil._psutil_posix' extension 06:47:05 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:47:05 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:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:05 INFO - Successfully installed psutil 06:47:05 INFO - Cleaning up... 06:47:05 INFO - Return code: 0 06:47:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:47:05 INFO - Using env: {'DISPLAY': ':0', 06:47:05 INFO - 'HOME': '/home/cltbld', 06:47:05 INFO - 'LANG': 'en_US.UTF-8', 06:47:05 INFO - 'LANGUAGE': 'en_US:en', 06:47:05 INFO - 'LOGNAME': 'cltbld', 06:47:05 INFO - 'MAIL': '/var/mail/cltbld', 06:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:05 INFO - 'MOZ_NO_REMOTE': '1', 06:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:05 INFO - 'NO_EM_RESTART': '1', 06:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:05 INFO - 'PWD': '/builds/slave/test', 06:47:05 INFO - 'SHELL': '/bin/bash', 06:47:05 INFO - 'SHLVL': '1', 06:47:05 INFO - 'TERM': 'linux', 06:47:05 INFO - 'TMOUT': '86400', 06:47:05 INFO - 'USER': 'cltbld', 06:47:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:05 INFO - '_': '/tools/buildbot/bin/python'} 06:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:47:06 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:47:06 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:47:06 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:47:06 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:47:06 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:47:06 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:47:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:47:08 INFO - Installing collected packages: mozsystemmonitor 06:47:08 INFO - Running setup.py install for mozsystemmonitor 06:47:08 INFO - Successfully installed mozsystemmonitor 06:47:08 INFO - Cleaning up... 06:47:08 INFO - Return code: 0 06:47:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:47:08 INFO - Using env: {'DISPLAY': ':0', 06:47:08 INFO - 'HOME': '/home/cltbld', 06:47:08 INFO - 'LANG': 'en_US.UTF-8', 06:47:08 INFO - 'LANGUAGE': 'en_US:en', 06:47:08 INFO - 'LOGNAME': 'cltbld', 06:47:08 INFO - 'MAIL': '/var/mail/cltbld', 06:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:08 INFO - 'MOZ_NO_REMOTE': '1', 06:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:08 INFO - 'NO_EM_RESTART': '1', 06:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:08 INFO - 'PWD': '/builds/slave/test', 06:47:08 INFO - 'SHELL': '/bin/bash', 06:47:08 INFO - 'SHLVL': '1', 06:47:08 INFO - 'TERM': 'linux', 06:47:08 INFO - 'TMOUT': '86400', 06:47:08 INFO - 'USER': 'cltbld', 06:47:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:08 INFO - '_': '/tools/buildbot/bin/python'} 06:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:08 INFO - Downloading/unpacking jsonschema==2.5.1 06:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:47:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:47:10 INFO - warning: no files found matching '*.txt' 06:47:10 INFO - no previously-included directories found matching 'build' 06:47:10 INFO - no previously-included directories found matching 'dist' 06:47:10 INFO - no previously-included directories found matching '.git*' 06:47:10 INFO - Installing collected packages: jsonschema, functools32 06:47:10 INFO - Running setup.py install for functools32 06:47:10 INFO - warning: no files found matching '*.txt' 06:47:10 INFO - no previously-included directories found matching 'build' 06:47:10 INFO - no previously-included directories found matching 'dist' 06:47:10 INFO - no previously-included directories found matching '.git*' 06:47:10 INFO - Successfully installed jsonschema functools32 06:47:10 INFO - Cleaning up... 06:47:10 INFO - Return code: 0 06:47:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:10 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:10 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:47:10 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:47:10 INFO - Using env: {'DISPLAY': ':0', 06:47:10 INFO - 'HOME': '/home/cltbld', 06:47:10 INFO - 'LANG': 'en_US.UTF-8', 06:47:10 INFO - 'LANGUAGE': 'en_US:en', 06:47:10 INFO - 'LOGNAME': 'cltbld', 06:47:10 INFO - 'MAIL': '/var/mail/cltbld', 06:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:10 INFO - 'MOZ_NO_REMOTE': '1', 06:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:10 INFO - 'NO_EM_RESTART': '1', 06:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:10 INFO - 'PWD': '/builds/slave/test', 06:47:10 INFO - 'SHELL': '/bin/bash', 06:47:10 INFO - 'SHLVL': '1', 06:47:10 INFO - 'TERM': 'linux', 06:47:10 INFO - 'TMOUT': '86400', 06:47:10 INFO - 'USER': 'cltbld', 06:47:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:10 INFO - '_': '/tools/buildbot/bin/python'} 06:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:47:11 INFO - Cleaning up... 06:47:11 INFO - Return code: 0 06:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:11 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:11 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:47:11 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:47:11 INFO - Using env: {'DISPLAY': ':0', 06:47:11 INFO - 'HOME': '/home/cltbld', 06:47:11 INFO - 'LANG': 'en_US.UTF-8', 06:47:11 INFO - 'LANGUAGE': 'en_US:en', 06:47:11 INFO - 'LOGNAME': 'cltbld', 06:47:11 INFO - 'MAIL': '/var/mail/cltbld', 06:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:11 INFO - 'MOZ_NO_REMOTE': '1', 06:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:11 INFO - 'NO_EM_RESTART': '1', 06:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:11 INFO - 'PWD': '/builds/slave/test', 06:47:11 INFO - 'SHELL': '/bin/bash', 06:47:11 INFO - 'SHLVL': '1', 06:47:11 INFO - 'TERM': 'linux', 06:47:11 INFO - 'TMOUT': '86400', 06:47:11 INFO - 'USER': 'cltbld', 06:47:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:11 INFO - '_': '/tools/buildbot/bin/python'} 06:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:47:11 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:47:11 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:47:11 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:47:11 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:47:11 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:47:11 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:47:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:13 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:47:13 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:47:13 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:47:13 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:47:13 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:47:13 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:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:47:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47:13 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:47:13 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:47:13 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:47:13 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:47:13 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:47:13 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:47:13 INFO - Downloading docopt-0.6.1.tar.gz 06:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:13 INFO - Running setup.py install for blobuploader 06:47:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:47:14 INFO - Running setup.py install for requests 06:47:14 INFO - Running setup.py install for docopt 06:47:14 INFO - Successfully installed blobuploader requests docopt 06:47:14 INFO - Cleaning up... 06:47:14 INFO - Return code: 0 06:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:14 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:47:14 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:47:14 INFO - Using env: {'DISPLAY': ':0', 06:47:14 INFO - 'HOME': '/home/cltbld', 06:47:14 INFO - 'LANG': 'en_US.UTF-8', 06:47:14 INFO - 'LANGUAGE': 'en_US:en', 06:47:14 INFO - 'LOGNAME': 'cltbld', 06:47:14 INFO - 'MAIL': '/var/mail/cltbld', 06:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:14 INFO - 'MOZ_NO_REMOTE': '1', 06:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:14 INFO - 'NO_EM_RESTART': '1', 06:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:14 INFO - 'PWD': '/builds/slave/test', 06:47:14 INFO - 'SHELL': '/bin/bash', 06:47:14 INFO - 'SHLVL': '1', 06:47:14 INFO - 'TERM': 'linux', 06:47:14 INFO - 'TMOUT': '86400', 06:47:14 INFO - 'USER': 'cltbld', 06:47:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:14 INFO - '_': '/tools/buildbot/bin/python'} 06:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:14 INFO - Running setup.py (path:/tmp/pip-AJTq12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:14 INFO - Running setup.py (path:/tmp/pip-frH074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:14 INFO - Running setup.py (path:/tmp/pip-8ipHDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:14 INFO - Running setup.py (path:/tmp/pip-uHj865-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:15 INFO - Running setup.py (path:/tmp/pip-CUeU8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:15 INFO - Running setup.py (path:/tmp/pip-ddvbOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:15 INFO - Running setup.py (path:/tmp/pip-X36G5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:15 INFO - Running setup.py (path:/tmp/pip-2Bl6ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:15 INFO - Running setup.py (path:/tmp/pip-qUfx8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:15 INFO - Running setup.py (path:/tmp/pip-ZYzwUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:15 INFO - Running setup.py (path:/tmp/pip-wJwYCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:15 INFO - Running setup.py (path:/tmp/pip-Py7Ahi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:15 INFO - Running setup.py (path:/tmp/pip-e9HFFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:15 INFO - Running setup.py (path:/tmp/pip-IqYHsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:15 INFO - Running setup.py (path:/tmp/pip-GELQ3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:15 INFO - Running setup.py (path:/tmp/pip-hpWPNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:15 INFO - Running setup.py (path:/tmp/pip-yYqFsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:16 INFO - Running setup.py install for manifestparser 06:47:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Running setup.py install for mozcrash 06:47:16 INFO - Running setup.py install for mozdebug 06:47:16 INFO - Running setup.py install for mozdevice 06:47:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Running setup.py install for mozfile 06:47:16 INFO - Running setup.py install for mozhttpd 06:47:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Running setup.py install for mozinfo 06:47:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Running setup.py install for mozInstall 06:47:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:47:16 INFO - Running setup.py install for mozleak 06:47:16 INFO - Running setup.py install for mozlog 06:47:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Running setup.py install for moznetwork 06:47:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Running setup.py install for mozprocess 06:47:17 INFO - Running setup.py install for mozprofile 06:47:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Running setup.py install for mozrunner 06:47:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Running setup.py install for mozscreenshot 06:47:17 INFO - Running setup.py install for moztest 06:47:17 INFO - Running setup.py install for mozversion 06:47:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:47:17 INFO - Cleaning up... 06:47:17 INFO - Return code: 0 06:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:17 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 06:47:17 INFO - 'HOME': '/home/cltbld', 06:47:17 INFO - 'LANG': 'en_US.UTF-8', 06:47:17 INFO - 'LANGUAGE': 'en_US:en', 06:47:17 INFO - 'LOGNAME': 'cltbld', 06:47:17 INFO - 'MAIL': '/var/mail/cltbld', 06:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:17 INFO - 'MOZ_NO_REMOTE': '1', 06:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:17 INFO - 'NO_EM_RESTART': '1', 06:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:17 INFO - 'PWD': '/builds/slave/test', 06:47:17 INFO - 'SHELL': '/bin/bash', 06:47:17 INFO - 'SHLVL': '1', 06:47:17 INFO - 'TERM': 'linux', 06:47:17 INFO - 'TMOUT': '86400', 06:47:17 INFO - 'USER': 'cltbld', 06:47:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:17 INFO - '_': '/tools/buildbot/bin/python'} 06:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:18 INFO - Running setup.py (path:/tmp/pip-bFWTQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:18 INFO - Running setup.py (path:/tmp/pip-uNEIzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:18 INFO - Running setup.py (path:/tmp/pip-7K6mKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:18 INFO - Running setup.py (path:/tmp/pip-noXhyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:18 INFO - Running setup.py (path:/tmp/pip-99gK05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:18 INFO - Running setup.py (path:/tmp/pip-OnYZoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:18 INFO - Running setup.py (path:/tmp/pip-xpbwAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:18 INFO - Running setup.py (path:/tmp/pip-mP0D8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:18 INFO - Running setup.py (path:/tmp/pip-gpxNyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:18 INFO - Running setup.py (path:/tmp/pip-HM5JS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:18 INFO - Running setup.py (path:/tmp/pip-QmEbg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:18 INFO - Running setup.py (path:/tmp/pip-ueiMfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:18 INFO - Running setup.py (path:/tmp/pip-A7qblA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:18 INFO - Running setup.py (path:/tmp/pip-Q8BUOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:19 INFO - Running setup.py (path:/tmp/pip-b949jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:19 INFO - Running setup.py (path:/tmp/pip-DWUO9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:19 INFO - Running setup.py (path:/tmp/pip-WJI5to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:19 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:47:19 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:47:19 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:47:19 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:47:19 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:47:19 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:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:47: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:47: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:47: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:47: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:47: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:47: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:47:21 INFO - Downloading blessings-1.6.tar.gz 06:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:47:21 INFO - Installing collected packages: blessings 06:47:21 INFO - Running setup.py install for blessings 06:47:21 INFO - Successfully installed blessings 06:47:21 INFO - Cleaning up... 06:47:21 INFO - Return code: 0 06:47:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:21 INFO - Reading from file tmpfile_stdout 06:47:21 INFO - Current package versions: 06:47:21 INFO - argparse == 1.2.1 06:47:21 INFO - blessings == 1.6 06:47:21 INFO - blobuploader == 1.2.4 06:47:21 INFO - docopt == 0.6.1 06:47:21 INFO - functools32 == 3.2.3-2 06:47:21 INFO - jsonschema == 2.5.1 06:47:21 INFO - manifestparser == 1.1 06:47:21 INFO - mozInstall == 1.12 06:47:21 INFO - mozcrash == 0.17 06:47:21 INFO - mozdebug == 0.1 06:47:21 INFO - mozdevice == 0.48 06:47:21 INFO - mozfile == 1.2 06:47:21 INFO - mozhttpd == 0.7 06:47:21 INFO - mozinfo == 0.9 06:47:21 INFO - mozleak == 0.1 06:47:21 INFO - mozlog == 3.4 06:47:21 INFO - moznetwork == 0.27 06:47:21 INFO - mozprocess == 0.23 06:47:21 INFO - mozprofile == 0.28 06:47:21 INFO - mozrunner == 6.12 06:47:21 INFO - mozscreenshot == 0.1 06:47:21 INFO - mozsystemmonitor == 0.3 06:47:21 INFO - moztest == 0.7 06:47:21 INFO - mozversion == 1.4 06:47:21 INFO - psutil == 3.1.1 06:47:21 INFO - requests == 1.2.3 06:47:21 INFO - wsgiref == 0.1.2 06:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:21 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:21 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:47:21 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:47:21 INFO - Using env: {'DISPLAY': ':0', 06:47:21 INFO - 'HOME': '/home/cltbld', 06:47:21 INFO - 'LANG': 'en_US.UTF-8', 06:47:21 INFO - 'LANGUAGE': 'en_US:en', 06:47:21 INFO - 'LOGNAME': 'cltbld', 06:47:21 INFO - 'MAIL': '/var/mail/cltbld', 06:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:21 INFO - 'MOZ_NO_REMOTE': '1', 06:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:21 INFO - 'NO_EM_RESTART': '1', 06:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:21 INFO - 'PWD': '/builds/slave/test', 06:47:21 INFO - 'SHELL': '/bin/bash', 06:47:21 INFO - 'SHLVL': '1', 06:47:21 INFO - 'TERM': 'linux', 06:47:21 INFO - 'TMOUT': '86400', 06:47:21 INFO - 'USER': 'cltbld', 06:47:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:21 INFO - '_': '/tools/buildbot/bin/python'} 06:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Cleaning up... 06:47:22 INFO - Return code: 0 06:47:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:47:22 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:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:22 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:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:22 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 0x7fab8be52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1187790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, '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': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 06:47:22 INFO - 'HOME': '/home/cltbld', 06:47:22 INFO - 'LANG': 'en_US.UTF-8', 06:47:22 INFO - 'LANGUAGE': 'en_US:en', 06:47:22 INFO - 'LOGNAME': 'cltbld', 06:47:22 INFO - 'MAIL': '/var/mail/cltbld', 06:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:22 INFO - 'MOZ_NO_REMOTE': '1', 06:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:22 INFO - 'NO_EM_RESTART': '1', 06:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:22 INFO - 'PWD': '/builds/slave/test', 06:47:22 INFO - 'SHELL': '/bin/bash', 06:47:22 INFO - 'SHLVL': '1', 06:47:22 INFO - 'TERM': 'linux', 06:47:22 INFO - 'TMOUT': '86400', 06:47:22 INFO - 'USER': 'cltbld', 06:47:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:22 INFO - '_': '/tools/buildbot/bin/python'} 06:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:47:22 INFO - Cleaning up... 06:47:22 INFO - Return code: 0 06:47:22 INFO - Running post-action listener: _resource_record_post_action 06:47:22 INFO - Running post-action listener: _start_resource_monitoring 06:47:22 INFO - Starting resource monitoring. 06:47:22 INFO - [mozharness: 2016-09-27 13:47:22.327508Z] Finished create-virtualenv step (success) 06:47:22 INFO - [mozharness: 2016-09-27 13:47:22.327974Z] Running install step. 06:47:22 INFO - Running pre-action listener: _resource_record_pre_action 06:47:22 INFO - Running main action method: install 06:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:22 INFO - Reading from file tmpfile_stdout 06:47:22 INFO - Detecting whether we're running mozinstall >=1.0... 06:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:47:22 INFO - Reading from file tmpfile_stdout 06:47:22 INFO - Output received: 06:47:22 INFO - Usage: mozinstall [options] installer 06:47:22 INFO - Options: 06:47:22 INFO - -h, --help show this help message and exit 06:47:22 INFO - -d DEST, --destination=DEST 06:47:22 INFO - Directory to install application into. [default: 06:47:22 INFO - "/builds/slave/test"] 06:47:22 INFO - --app=APP Application being installed. [default: firefox] 06:47:22 INFO - mkdir: /builds/slave/test/build/application 06:47:22 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:47:22 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:47:39 INFO - Reading from file tmpfile_stdout 06:47:39 INFO - Output received: 06:47:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:47:39 INFO - Running post-action listener: _resource_record_post_action 06:47:39 INFO - [mozharness: 2016-09-27 13:47:39.616358Z] Finished install step (success) 06:47:39 INFO - [mozharness: 2016-09-27 13:47:39.616607Z] Running run-tests step. 06:47:39 INFO - Running pre-action listener: _resource_record_pre_action 06:47:39 INFO - Running main action method: run_tests 06:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:47:39 INFO - Python 2.7.3 06:47:39 INFO - Return code: 0 06:47:39 INFO - grabbing minidump binary from tooltool 06:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:39 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 0x1184930>, '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 0x1185830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1185cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:47:39 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:47:39 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:47:39 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:47:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:47:39 INFO - Return code: 0 06:47:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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:47:39 INFO - Using env: {'DISPLAY': ':0', 06:47:39 INFO - 'HOME': '/home/cltbld', 06:47:39 INFO - 'LANG': 'en_US.UTF-8', 06:47:39 INFO - 'LANGUAGE': 'en_US:en', 06:47:39 INFO - 'LOGNAME': 'cltbld', 06:47:39 INFO - 'MAIL': '/var/mail/cltbld', 06:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:39 INFO - 'MOZ_NO_REMOTE': '1', 06:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:39 INFO - 'NO_EM_RESTART': '1', 06:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:39 INFO - 'PWD': '/builds/slave/test', 06:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:47:39 INFO - 'SHELL': '/bin/bash', 06:47:39 INFO - 'SHLVL': '1', 06:47:39 INFO - 'TERM': 'linux', 06:47:39 INFO - 'TMOUT': '86400', 06:47:39 INFO - 'USER': 'cltbld', 06:47:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809', 06:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:39 INFO - '_': '/tools/buildbot/bin/python'} 06:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:47:39 INFO - mozversion application_buildid: 20160927033005 06:47:39 INFO - mozversion application_changeset: 93bc88233717f6bc59806810664c5c1256e7e367 06:47:39 INFO - mozversion application_display_name: Nightly 06:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:47:39 INFO - mozversion application_name: Firefox 06:47:39 INFO - mozversion application_remotingname: firefox 06:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:47:39 INFO - mozversion application_vendor: Mozilla 06:47:39 INFO - mozversion application_version: 52.0a1 06:47:39 INFO - mozversion platform_buildid: 20160927033005 06:47:39 INFO - mozversion platform_changeset: 93bc88233717f6bc59806810664c5c1256e7e367 06:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:47:39 INFO - mozversion platform_version: 52.0a1 06:47:39 INFO - using testdate: 1474984059 06:47:39 INFO - actual date: 1474984059 06:47:39 INFO - starting webserver on 'localhost:33204' 06:47:39 INFO - SUITE-START | Running 2 tests 06:47:39 INFO - TEST-START | dromaeo_css 06:47:39 INFO - operating with platform_type : linux_ 06:47:39 INFO - Initialising browser for dromaeo_css test... 06:47:39 INFO - TEST-INFO | started process 27884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp302P19/profile http://localhost:33204/getInfo.html) 06:47:44 INFO - PROCESS | 27884 | __metrics Screen width/height:1600/1200 06:47:44 INFO - PROCESS | 27884 | colorDepth:24 06:47:44 INFO - PROCESS | 27884 | Browser inner width/height: 1024/697 06:47:44 INFO - PROCESS | 27884 | __metrics 06:47:44 INFO - PROCESS | 27884 | 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:47:44 INFO - PROCESS | 27884 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:45 INFO - PROCESS | 27884 | console.error: PushService: 06:47:45 INFO - PROCESS | 27884 | stateChangeProcessEnqueue: Error transitioning state 06:47:45 INFO - PROCESS | 27884 | UnknownError 06:47:46 INFO - TEST-INFO | 27884: exit 0 06:47:46 INFO - Browser initialized. 06:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 06:47:46 INFO - TEST-INFO | started process 27967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp302P19/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:58 INFO - PROCESS | 27967 | RSS: Main: 174071808 06:47:58 INFO - PROCESS | 27967 | 06:48:49 INFO - PROCESS | 27967 | 1474984129574 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:50:59 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33204/tests/dromaeo/cssquery-ext.html) 06:51:00 INFO - PROCESS | 27967 | RSS: Main: 300253184 06:51:00 INFO - PROCESS | 27967 | 06:54:02 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-ext.html (next: http://localhost:33204/tests/dromaeo/cssquery-jquery.html) 06:54:03 INFO - PROCESS | 27967 | RSS: Main: 275947520 06:54:03 INFO - PROCESS | 27967 | 06:57:05 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33204/tests/dromaeo/cssquery-mootools.html) 06:57:06 INFO - PROCESS | 27967 | RSS: Main: 217268224 06:57:06 INFO - PROCESS | 27967 | 07:00:08 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33204/tests/dromaeo/cssquery-prototype.html) 07:00:08 INFO - PROCESS | 27967 | RSS: Main: 249090048 07:00:08 INFO - PROCESS | 27967 | 07:03:11 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33204/tests/dromaeo/cssquery-yui.html) 07:03:12 INFO - PROCESS | 27967 | RSS: Main: 217071616 07:03:12 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:33204/tests/dromaeo/cssquery-yui.html (next: http://localhost:33204/tests/dromaeo/cssquery-dojo.html) 07:06:15 INFO - PROCESS | 27967 | RSS: Main: 306765824 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | __start_tp_report 07:06:15 INFO - PROCESS | 27967 | _x_x_mozilla_page_load 07:06:15 INFO - PROCESS | 27967 | _x_x_mozilla_page_load_details 07:06:15 INFO - PROCESS | 27967 | |i|pagename|runs| 07:06:15 INFO - PROCESS | 27967 | |0;dojo.html;3039.376927729815;3064.9999999999986;3069.9079027629173;3100.488419410797;3112.7665425093123;5287.365516138059;5329.440408757083;5365.785368585257;5408.2158087077305;5424.647397919142;5372.838814835552;5394.73026348682;5409.323834520685;5411.242426060345;5413.485718856702;4967.10592093423;4967.155583550796;4970.577500912426;4980.800767969295;5024.271480635306;4960.107180707471;4973.154563724175;5050.7979680812905;5055.696658200502;5057.241413787924;5040.042391945537;5087.567556757662;5107.4892510749;5114.667546609477;5117.1556693145585;4934.9753251233515;4980.551750342486;4992.07646585381;5001.649884508086;5002.799888004475;4790.473047964721;4835.032993401333;4847.175980083394;4859.198232291667;4872.902541949141;5316.867078323035;5323.574114070865;5323.760430780624;5336.706481143536;5352.384475785296;5798.101294299348;5799.7100144993;5802.854928626776;5806.216160818278;5806.477417032487;5657.915131273035;5680.602357834953;5756.913646295309;5778.855528611776;5825.155352473867;5395.919061214085;5397.676139431607;5413.918791218135;5418.945810541923;5476.780928762844;5944.762209511658;5954.255718035246;5956.463918247378;5956.821295361146;5959.195508606369;5527.917081243784;5531.751071201806;5581.10702287632;5586.301712285965;5734.885302293931;5718.313802343745;5737.139429085671;5739.196512488255;5803.129530570448;5803.564732645069;5723;5728.05487094633;5729.054705973551;5733.3406658234;5733.541316694738;5600.159976003632;5654.37801841797;5736.368999410061;5737.340205876294;5794.652320860761;4418.381426600278;4419.337099435111;4455.6658250631335;4463.107378524308;4512.481064677604;3947.881563553098;3949.7037722170953;3968.206358728266;3995.6403923647013;4017.196560687874;5388.137897936312;5466.180072989004;5513.531349835309;5520.53075488588;5532.889342213133;5712.6286791358425;5728.684922329228;5769.423057694197;5779.797707080316;5870.14882841994;5489.807856724996;5518.2826232589505;5518.862028449321;5520.723963801794;5523.25436066134;5018.4981501849525;5025.698458092453;5031.6729412588065;5036.143855544567;5078.263651770547;5864.618799778001;5896.321922978912;5926;5959.791407300723;5962.701864906824;5770.884582308414;5774.249347584787;5775.1914731938405;5780.595358325045;5879.617824841372;5963.135345374983;5963.224780778471;5967.254093238345;5969.432903874125;5969.52243820502;5589.273394458694;5599.132134519156;5630.268065151504;5657.066584013592;5680.943190568207;5794.681292528951;5802.071668533014;5807.448292412214;5853.678047707417;5871.794487192928;5682.261306030189;5687.260656114844;5690.77236910519;5691.630044047124;5694.288213973254;5483.259759932517;5498;5644.463775941279;5654.943450565442;5664.603477756682;5659.151127330933;5679.318481782213;5689.6586204827845;5753.8561535961935;5759.136129580596;5683.232763576864;5701.059325211294;5715.542756579547;5721.542276617944;5741.25363702716;5379.273798037215;5418.620696551204;5489.039418101896;5542.972285138549;5548.916766248591 07:06:15 INFO - PROCESS | 27967 | |1;ext.html;552.8861336352021;583.7168973048072;611.4924612571565;622.9937700622993;638.5785381648113;30447.08658740236;41914;42808.3578746319;42941.14117717644;43084.784576077116;44145.55854441455;44486;44582.777086114605;44679;44730;8127.75616731496;8360.958195209016;8919.866202006975;9075.773105672344;9078.273738100968;10608.628697995571;10848.29486083406;10850.186236032328;11216.887831121667;11251.493682784254;10977.28647637901;11026.724331891686;11046.779064418746;11074.501647425845;11082.778344433107;10842.457877106153;10894.400807955559;10907.454627268684;10910.61812836547;10914.454277286104;10676.145908327315;10765.83851242232;10766.300190487671;10767.407792571405;10776.67669969902;41754;42144;42166.367504487454;42202.57797422017;42217.36673949893;2973.7769667274824;3096.612923384577;3134.420132275536;3267.0688853676825;3283.868645254187;31605.84197079;32232.033039008867;32252.6774732252;32323.676763232535;33140;4240.363945408182;4260.147970405931;4358.389825424443;4420.46954365475;4560.498345182027;325692;327499;328677;329615;329765;55672;56232.15651765145;56570;56590.7170464145;56630.168491575256;59180.40819591835;59187;59244.40755592475;59261;59298.40701592929;14684.26578671062;14851.480198193012;14858.405663773328;14860.479883204252;14861.851381486047;10002.799944001225;10283.485825708685;10293.74265643365;10507.422091785025;11526.538938442536;15000.549983500512;15935.760963585555;16373.508794736177;16376.590585235464;16960.236789344508;5740.799072032542;6365.936340636627;6461.57999730016;6480.643564603898;6496.967515162394;945.6264775413811;950.8288508068614;1062.7821296634172;1075.473018221066;1096.819024860889;27592.724072759014;27625.447491050065;27935.58096628552;28037.579436308064;28150;1090.9399983000853;1115.286216821235;1123.0285802780536;1130.4291332876844;1136.3693150301663;16156.676866462605;16287;16669.24988375526;16806.831931680772;16930.09800743151;483851;486226;486953;487318;491248;55995.44004559984;56019;56122;56170.43829561652;56267;1283.826683397748;1332.9000324975666;1340.2427628389928;1346.9461221551028;1353.2163800963547;29378.412431750818;30824.69175308218;31420.842895785376;32386.676133238365;32598.718997545857;53513.732431337594;54302.45697542974;54319.45680543302;54346.72826635841;54349.45650543602;419891;421723;423009;423073;423282;22783.924170237467;23240.767592324537;27709.58435623427;28178.2955426116;28232.43535129245;45964.310535342665;46147.307790382496;46315.305270421646;46825;46958.76520617375;38710.2257954845;38917.22165556729;39268.60731392649;39613.40579891246;40914.38628420517;38142.237155257295;38200.426993595676;39002.804985974886;39540.40689389719;40181.1963760729;39605.80197098996;39689.801550993216;40123.598764011986;40424;40722;33214.501782473766;35796.284074317846;36762.63237367592;36804.26391472102;36806.26387472182;33872.49191262182;34459.4831077529;36444.27111457809;36739.816300918326;36860 07:06:15 INFO - PROCESS | 27967 | |2;jquery.html;379.16772683958686;401.5803485357803;403.3747691078828;404.56105125938365;421.34901577063437;13533.255670938095;15536.067835929838;19091.236350545998;19463.610727785435;19772.802271977274;18791.906040469814;18949.33677321294;19299.80700193001;19492.22031118757;19499.12253948572;5080.618953578478;5657.094864821629;5869.677167755772;5872.8238152855265;5876;6385.968070159643;6401.679916004181;6451.354864513558;6477.83805404864;6487.318831522693;6234.5324100692405;6436.806895793134;6460.160179176701;6470.288268290485;6512.088307636935;6296.685165741695;6523.05415714721;6544.574602650812;6560.868782624345;6562.540622156451;5675.3757086720425;5716.142578613241;5717.285339332583;5719.456651618089;5719.485246327808;18824.717629235573;19233.615327693507;22864.77135228643;22869.199578014857;23076.4230894229;2242.854214476054;2350.6121489954307;2402.243293362603;2486.614574740918;2984.5075562532156;13539.59381218565;14055.78916316256;14095.506657266946;14592.781108283278;14995.925020374829;1840.530664680498;1909.0645583663904;1924.5477312831474;1932.9935170980382;1968.6653268944315;80639;80975.30734580205;82060;82451.17548824554;82592.58703706504;10338.689839304832;10408.167346612252;10656.786864262827;10855.023047925724;11036.11711063113;13903.235322057182;13903.374348154357;13906.51327203543;13914.652133696536;13918.791218131737;7415.930702291799;7589.810254743676;7640.312371886557;7682.078150621961;7746.109197442253;7071.116110486189;7122.05308567352;7133.89299160513;7420.443466740016;7449.515781474187;6498.870022599522;6508.902366464412;6529.085927970088;6546.509011824132;6679.812791278078;1844.9262029518668;1864;1884.6607610630217;1895.1661269041579;1947.4449781812116;780.5277806926841;852.6972924611797;859.3082568532267;925.3337596930199;965.5510187762584;17344.382728883964;17663;18158.90920545415;18520.81479185191;18541.258349666132;891.460666296894;896.4979611417627;921.2767977137914;935.1303287942143;962.8411312133419;9846.655367062262;10468.895311046945;10500.474976251156;10582.100521455608;10587.682369528926;384184;388154;389167;452452;465648;59200.703996479744;64857;93515.53242233745;96456.51771741237;97965.5101724501;1019.1490105761624;1030.1655658916302;1054.6045233037612;1060.3637817309552;1073.7598074224127;17686.557836054202;17885;18558.81441185571;18566.907165464087;18922.810771892655;42301.78849105735;42553.36169957515;42585.29658813613;42645.36031959585;43790.56209437865;58964.41035589589;59026.70486647539;59173.40826591679;60539.69730151497;60889.69555152196;8419.466297843908;8495.660173592987;8523.105073967145;8534.871976920474;8612.311015118901;9898.356606820533;12322.32227227511;12740.235585864877;12890.613281601567;13041.478340866259;10842.674719758419;11220.495077721358;11292.43537823122;11839.408029598659;11857.5849845255;11084.722881928017;11170.385628790495;11525.88474115248;11603.6518904433;11865.762684746083;11318.32090074598;11589.768204635691;11946.940265298617;12190.878091219329;12208;8592.957035214784;8729.476231426135;8822.33832462555;8903.510306933182;9052.90947090547;10789.73025674333;10928;11006.779864402828;11451.312921224753;11607.419629018685 07:06:15 INFO - PROCESS | 27967 | |3;mootools.html;1244.129109623264;1442.826860776707;1451.0713143588102;1597;1785.4732853808118;7941.483803552772;8692.869606955894;8993.235574976135;9001.50491722955;9226.308026897992;8986.910130898688;8999.640014399416;9066.274698024159;9076.727698169048;9095.90904090959;2320.6286994080906;2347.3427440316655;2352.8588284702887;2354.0466111224982;2355.634876594122;2274.351809734226;2323.465602911331;2336.4392545788974;2341.2976107167783;2341.4614638633125;2296.0586159674535;2304.9654255186188;2317.351141680332;2336.0655737704883;2336.170659415908;2262.4570103175283;2267.047839907243;2270.3302525754775;2273.9312523114195;2275.260540324393;2264.671622614728;2305.8501197422283;2308.953820923589;2309.4226443389152;2314.3866875278063;8771.517566533901;9018;9067.909320906838;9082.636694532277;9083.772905677344;5421.756020979065;5565.165225216209;5565.41563135873;5574.86062848428;5585.357683866367;3678;3682.355587772156;3724.9813750931344;3739.158689294914;3740.233252183296;1153.5097583527051;1166.8133098704252;1184.496588949693;1198.6943329450935;2000.3598848368529;12250.203736757083;12754.170978886435;12789.104762666617;12790.296533690644;12800.359982000862;4353.934690979638;4680.578747912704;4744.976275118603;4795.992841503324;4796.352492413549;9336;9339.906600933904;9340.112689294507;9350.438973661601;9355.625774969061;5371.355437347544;5408.432114627986;5409.053415652245;5445.101558242845;5452.073147564924;4270.829166833292;4403.119376124788;4885.5358740919555;4963.851084467472;5002.89994200114;3822.4839646647347;3834.9233015339537;3927.941080883732;3964.365701487748;3991.501062367204;1220.5178954312996;1227.9631611051682;1232.057476030837;1242.7203879127123;1255.215490318551;663.694700437804;833.1834801894178;943.3443756589242;958.7459323279337;962.2302158273353;5897.5871688982215;6017.1275165100815;6051.304100028553;6098.939010609926;6163.106349579286;442.61934736126904;450.6935284006841;452.80303068165455;454.86354093771735;596.0522768797632;4091.5499295077516;4133.524644665842;4180.623743863006;4188.267053265667;4215.304474761691;11014.779704405866;11336.093112550976;11444.798296178948;11454.942725286486;11468.139889508153;11255.493502792395;11295.887041129483;11304.547818087349;11305.71735706614;11321.377324247082;7902.723404680809;8129.918700813035;8202.220789025034;8304.377171712025;8321.417500774887;5897.64614123154;6280.371962803683;6294.087357333069;6323.905141422974;6345.46063584582;9940;10511.842322365017;10518.053375196268;10536.10443112344;10625.9468702656;10785.892141078803;10794.56821727122;10796.784064318826;10803.135749139892;10804.567817287221;8433;8443.408961372645;8561.400701950804;8563.95718021406;8565.48607083577;8128.390370722102;8431.367647426345;8489.108643592333;8581;8581.485110893367;7421.406287497095;7479.439042071757;7572;7573.659185336563;7789.221077892165;7575.0909890813455;7606.923930760621;7655.50239234448;7655.732049378245;7678.577678227528;7217.819554511179;7232.529885557422;7286.453515986216;7290.4896657233485;7291.562506249642;4983.302337672656;5060.772265247999;5068.949310506848;5101.285819985279;5125.564327032244;5146.6911985281;5256.710880901587;5330.093884039645;5442.319710036246;5455.236266922555 07:06:15 INFO - PROCESS | 27967 | |4;prototype.html;328.05866460825933;334.0279785823255;342.9348423799478;343.6065704768039;346.42493460854985;5074.746262686869;5202.687838729674;5232.895342093156;5249.606279529036;5250.474952504747;5023.171176755831;5151.278820965059;5159.974200129003;5177.844664660057;5181.507756763111;4101.662052630002;4113.691473139512;4115.917681646365;4118.8146533406;4123.36087906375;3961.762294262339;4079.8776036718946;4117.79697861644;4129.545749967501;4135.524414692319;4013.6989725770536;4027.7784721840285;4031.1736094100784;4032.5765794591584;4039.555648878621;4026.416169655384;4030.6775457963295;4041.979790101045;4057.6550993165615;4058.1072164123843;3566.7503274770775;3578.481120237551;3591.120175556979;3599.3701102307255;3601.8474088291755;5000.3248911614655;5060.368608323688;5092.668976516515;5123.666961647481;5127.307813445174;4609.608183304423;4622.075584883037;4628.305754136873;4634;4638;5426.158945363475;5428.511433970962;5433.510984011458;5434.510894019557;5441.374241962186;3801.346414309784;3883.8446462141483;3898.902527436837;3901.6878649708237;3908.9804550977065;5601.383847776782;5640.492355688008;5640.520555752766;5640.661560306395;5641.379448260729;4047.4535937648043;4054.2499637567144;4058;4072.205919845661;4104.507459104927;3915.7846318452757;4093.774842383638;4114.341705327193;4147.170565886835;4152.37714342845;4618.65360097994;4627.329037289574;4629.8148074077335;4640.1879671058105;4643.791029403685;5433.538149257279;5465.453454654582;5475.946520054979;5479.479449452296;5489.258950041693;1315.7828958221787;1330.3414809669275;1407.394820227312;1410.0693542262059;1413.2721648351107;888.4757992784288;902.1609902790468;916.7937214126902;917.7292698653913;918.5407296351824;4676.480143953228;4710.788014539354;4714.81140754366;4726.409198850144;4738;4923.655344125877;4928.556429921325;4939.3084968104495;4940.505949405031;4957.504249575014;4537.478190008125;4645.86062418128;4693.812247510062;4702.882427939329;4732.02993386355;2608.9347766305996;2618.9607155892677;2628.6199745133576;2630.763541135663;2647.8411295321957;5072;5085.821996230115;5101.8724531887;5120.13115212952;5128.794848206105;5033.572146367526;5037.848864534069;5040.395152581714;5060.761112887755;5419.674819510842;5739.368669446441;5781.641314291054;5827.825165245049;5832.745959618617;5848.2689663792025;5563.02647036775;5585.636933599303;5586.636868603528;5591.412901645269;5597.440255974533;5383.596230282823;5484.396716361117;5532.640378375554;5548.500634942875;5579.69311687861;5719.28508936383;5744.109663002241;5805.129230615273;5813.534917206529;5815.2149459822385;4033.515978082649;4050.817713202972;4072.75563466193;4094.1402305516176;4094.3653733671326;5380.569554435714;5419.891602168013;5612.242347283064;5646.124850648156;5652.519535839499;5281.33637904059;5420.991349800898;5488.926201327269;5504.256925315031;5511;5462.262594549685;5469.3983661797965;5517;5535.308086489189;5536;5317.388500322512;5479.835604931858;5498.835034948958;5501.367342755474;5524.723763811713;5486.902619476041;5495.587830912617;5496.433516447793;5497.790486093053;5562.833115006556;5384.703841288767;5402.27069345649;5421.82823048521;5423.29497165366;5444.6188766785945 07:06:15 INFO - PROCESS | 27967 | |5;yui.html;694.3056943056943;705.3334598804131;727.7271023366237;753.2806170107547;785.9646315915783;13879.653008674775;15335.923320383396;16027.679446411064;16072.11603361816;16076.437324693637;17055.147242637882;17082.572935676613;17087.82912170878;17098.316067357322;17277.395291164812;774.6475353714046;794.56696100625;796.1441450440799;797.2266901105918;798.4769975665948;653.9182602174728;678.0236459498332;768.4121646940096;791.3550456378063;801.0667572278318;818.8403261364036;820.0200760091693;821.1788211788212;823.4894365493402;824.5341382119113;824.4846970643318;825.0759149752316;826.557791581507;827.3298628111219;827.4497459189631;504.27132793113964;518.730260264664;519.2211682476286;521.8408385442439;591.8283697727654;13996.510122145675;14598.781018284733;14771.482998095122;14786.704265914621;14840;13505.459781608724;13509.662258443519;13674.384652690653;14305.05774591794;14441.638959026004;11841.467133978991;12416.627501174979;12543.874561254363;12557.874421255854;12674.176178548365;4294.184105020036;4320.6327462165755;4350.934735978963;4389;4488.618467430272;82648.17351826465;83658;85096.14903850944;85197.14802851954;85699.14300856974;9844.212463002943;9910.900890990997;10025.348352357074;10064.496775161213;10648.14814814813;18171.454856354332;18268.908655456904;18332.175052122686;18384.26462941494;18461;7245.365756428187;7253.528520646141;7326.194118646945;7396.297351751575;7427.368673662691;4495.595396414338;4552.362669226311;4609.746463944448;4636.281376386665;4646.697964632355;3231.0952933178746;3331.0506505645776;3337.18239031434;3340.9665903340656;3342.7325813934826;583.9299284085852;594.197832925547;601.9036954087325;611.9235095613049;624.0794827629302;568.8208214412447;588.2441063233724;589.39586923403;622.4273668225244;627.8963970944834;8539.786505337417;8634.481931084156;8703.695370662123;8860.246879015227;8977;600.891839468891;605.4702135631322;634.8444631065419;644.415232710989;647.5661306924372;4097.631213190827;4183.142455796555;4211.7472951623;4279.465066866642;4288.292431748727;112906.43546782213;114178;116841;117898;120284.39857800656;99890;100891;101018;104207;104578.47710761397;92227.53886230526;92822.53588732013;93002.0699793007;93169.53415233016;93203.53398232965;7961.840763184588;8010.679572817022;8045.597720114088;8048.798780030546;8266.13205613402;53154.73422632862;53224.00819938598;53969.730151348995;54061.459385407215;54248.728756355966;74066.25933740594;75113;76559.23440765744;77600.61199693965;78602.60698696699;9749.805003900025;9818.75453113678;10285.794284114425;10569;10599.62901298451;11124.833127502932;11156.888431115585;11167.553297868319;11443.25618834773;11569.595064172714;10436.217283703905;10694.465276736288;10867.184961127788;11229.438528073728;11412.771744565229;9689.563969621526;10062.144717699077;12037.097217708882;12478.625641230778;12524.248545087325;12402.75194496123;12547.623571292876;12875.484980601046;12887.097903147065;12895.290759008345;8924.107589241024;9628.66299679508;10290.691279261635;10410.531526081193;10586.417747023988;9979.301448898508;10462;10463;10834.945825270823;10852.18608604342 07:06:15 INFO - PROCESS | 27967 | __end_tp_report 07:06:15 INFO - PROCESS | 27967 | __start_cc_report 07:06:15 INFO - PROCESS | 27967 | _x_x_mozilla_cycle_collect,1011 07:06:15 INFO - PROCESS | 27967 | __end_cc_report 07:06:15 INFO - PROCESS | 27967 | __startTimestamp1474985175382__endTimestamp 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | ------- Summary: start ------- 07:06:15 INFO - PROCESS | 27967 | Number of tests: 6 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#0] dojo.html Cycles:165 Average:5374.20 Median:5542.97 stddev:599.80 (10.8%) stddev-sans-first:572.99 07:06:15 INFO - PROCESS | 27967 | Values: 3039.4 3065.0 3069.9 3100.5 3112.8 5287.4 5329.4 5365.8 5408.2 5424.6 5372.8 5394.7 5409.3 5411.2 5413.5 4967.1 4967.2 4970.6 4980.8 5024.3 4960.1 4973.2 5050.8 5055.7 5057.2 5040.0 5087.6 5107.5 5114.7 5117.2 4935.0 4980.6 4992.1 5001.6 5002.8 4790.5 4835.0 4847.2 4859.2 4872.9 5316.9 5323.6 5323.8 5336.7 5352.4 5798.1 5799.7 5802.9 5806.2 5806.5 5657.9 5680.6 5756.9 5778.9 5825.2 5395.9 5397.7 5413.9 5418.9 5476.8 5944.8 5954.3 5956.5 5956.8 5959.2 5527.9 5531.8 5581.1 5586.3 5734.9 5718.3 5737.1 5739.2 5803.1 5803.6 5723.0 5728.1 5729.1 5733.3 5733.5 5600.2 5654.4 5736.4 5737.3 5794.7 4418.4 4419.3 4455.7 4463.1 4512.5 3947.9 3949.7 3968.2 3995.6 4017.2 5388.1 5466.2 5513.5 5520.5 5532.9 5712.6 5728.7 5769.4 5779.8 5870.1 5489.8 5518.3 5518.9 5520.7 5523.3 5018.5 5025.7 5031.7 5036.1 5078.3 5864.6 5896.3 5926.0 5959.8 5962.7 5770.9 5774.2 5775.2 5780.6 5879.6 5963.1 5963.2 5967.3 5969.4 5969.5 5589.3 5599.1 5630.3 5657.1 5680.9 5794.7 5802.1 5807.4 5853.7 5871.8 5682.3 5687.3 5690.8 5691.6 5694.3 5483.3 5498.0 5644.5 5654.9 5664.6 5659.2 5679.3 5689.7 5753.9 5759.1 5683.2 5701.1 5715.5 5721.5 5741.3 5379.3 5418.6 5489.0 5543.0 5548.9 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#1] ext.html Cycles:180 Average:57575.58 Median:36783.45 stddev:110421.74 (300.2%) stddev-sans-first:110648.50 07:06:15 INFO - PROCESS | 27967 | Values: 552.9 583.7 611.5 623.0 638.6 30447.1 41914.0 42808.4 42941.1 43084.8 44145.6 44486.0 44582.8 44679.0 44730.0 8127.8 8361.0 8919.9 9075.8 9078.3 10608.6 10848.3 10850.2 11216.9 11251.5 10977.3 11026.7 11046.8 11074.5 11082.8 10842.5 10894.4 10907.5 10910.6 10914.5 10676.1 10765.8 10766.3 10767.4 10776.7 41754.0 42144.0 42166.4 42202.6 42217.4 2973.8 3096.6 3134.4 3267.1 3283.9 31605.8 32232.0 32252.7 32323.7 33140.0 4240.4 4260.1 4358.4 4420.5 4560.5 325692.0 327499.0 328677.0 329615.0 329765.0 55672.0 56232.2 56570.0 56590.7 56630.2 59180.4 59187.0 59244.4 59261.0 59298.4 14684.3 14851.5 14858.4 14860.5 14861.9 10002.8 10283.5 10293.7 10507.4 11526.5 15000.5 15935.8 16373.5 16376.6 16960.2 5740.8 6365.9 6461.6 6480.6 6497.0 945.6 950.8 1062.8 1075.5 1096.8 27592.7 27625.4 27935.6 28037.6 28150.0 1090.9 1115.3 1123.0 1130.4 1136.4 16156.7 16287.0 16669.2 16806.8 16930.1 483851.0 486226.0 486953.0 487318.0 491248.0 55995.4 56019.0 56122.0 56170.4 56267.0 1283.8 1332.9 1340.2 1346.9 1353.2 29378.4 30824.7 31420.8 32386.7 32598.7 53513.7 54302.5 54319.5 54346.7 54349.5 419891.0 421723.0 423009.0 423073.0 423282.0 22783.9 23240.8 27709.6 28178.3 28232.4 45964.3 46147.3 46315.3 46825.0 46958.8 38710.2 38917.2 39268.6 39613.4 40914.4 38142.2 38200.4 39002.8 39540.4 40181.2 39605.8 39689.8 40123.6 40424.0 40722.0 33214.5 35796.3 36762.6 36804.3 36806.3 33872.5 34459.5 36444.3 36739.8 36860.0 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#2] jquery.html Cycles:180 Average:26757.91 Median:388660.50 stddev:69159.85 (17.8%) stddev-sans-first:69325.50 07:06:15 INFO - PROCESS | 27967 | Values: 379.2 401.6 403.4 404.6 421.3 13533.3 15536.1 19091.2 19463.6 19772.8 18791.9 18949.3 19299.8 19492.2 19499.1 5080.6 5657.1 5869.7 5872.8 5876.0 6386.0 6401.7 6451.4 6477.8 6487.3 6234.5 6436.8 6460.2 6470.3 6512.1 6296.7 6523.1 6544.6 6560.9 6562.5 5675.4 5716.1 5717.3 5719.5 5719.5 18824.7 19233.6 22864.8 22869.2 23076.4 2242.9 2350.6 2402.2 2486.6 2984.5 13539.6 14055.8 14095.5 14592.8 14995.9 1840.5 1909.1 1924.5 1933.0 1968.7 80639.0 80975.3 82060.0 82451.2 82592.6 10338.7 10408.2 10656.8 10855.0 11036.1 13903.2 13903.4 13906.5 13914.7 13918.8 7415.9 7589.8 7640.3 7682.1 7746.1 7071.1 7122.1 7133.9 7420.4 7449.5 6498.9 6508.9 6529.1 6546.5 6679.8 1844.9 1864.0 1884.7 1895.2 1947.4 780.5 852.7 859.3 925.3 965.6 17344.4 17663.0 18158.9 18520.8 18541.3 891.5 896.5 921.3 935.1 962.8 9846.7 10468.9 10500.5 10582.1 10587.7 384184.0 388154.0 389167.0 452452.0 465648.0 59200.7 64857.0 93515.5 96456.5 97965.5 1019.1 1030.2 1054.6 1060.4 1073.8 17686.6 17885.0 18558.8 18566.9 18922.8 42301.8 42553.4 42585.3 42645.4 43790.6 58964.4 59026.7 59173.4 60539.7 60889.7 8419.5 8495.7 8523.1 8534.9 8612.3 9898.4 12322.3 12740.2 12890.6 13041.5 10842.7 11220.5 11292.4 11839.4 11857.6 11084.7 11170.4 11525.9 11603.7 11865.8 11318.3 11589.8 11946.9 12190.9 12208.0 8593.0 8729.5 8822.3 8903.5 9052.9 10789.7 10928.0 11006.8 11451.3 11607.4 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#3] mootools.html Cycles:180 Average:5891.11 Median:4924.69 stddev:3395.63 (69.0%) stddev-sans-first:3387.20 07:06:15 INFO - PROCESS | 27967 | Values: 1244.1 1442.8 1451.1 1597.0 1785.5 7941.5 8692.9 8993.2 9001.5 9226.3 8986.9 8999.6 9066.3 9076.7 9095.9 2320.6 2347.3 2352.9 2354.0 2355.6 2274.4 2323.5 2336.4 2341.3 2341.5 2296.1 2305.0 2317.4 2336.1 2336.2 2262.5 2267.0 2270.3 2273.9 2275.3 2264.7 2305.9 2309.0 2309.4 2314.4 8771.5 9018.0 9067.9 9082.6 9083.8 5421.8 5565.2 5565.4 5574.9 5585.4 3678.0 3682.4 3725.0 3739.2 3740.2 1153.5 1166.8 1184.5 1198.7 2000.4 12250.2 12754.2 12789.1 12790.3 12800.4 4353.9 4680.6 4745.0 4796.0 4796.4 9336.0 9339.9 9340.1 9350.4 9355.6 5371.4 5408.4 5409.1 5445.1 5452.1 4270.8 4403.1 4885.5 4963.9 5002.9 3822.5 3834.9 3927.9 3964.4 3991.5 1220.5 1228.0 1232.1 1242.7 1255.2 663.7 833.2 943.3 958.7 962.2 5897.6 6017.1 6051.3 6098.9 6163.1 442.6 450.7 452.8 454.9 596.1 4091.5 4133.5 4180.6 4188.3 4215.3 11014.8 11336.1 11444.8 11454.9 11468.1 11255.5 11295.9 11304.5 11305.7 11321.4 7902.7 8129.9 8202.2 8304.4 8321.4 5897.6 6280.4 6294.1 6323.9 6345.5 9940.0 10511.8 10518.1 10536.1 10625.9 10785.9 10794.6 10796.8 10803.1 10804.6 8433.0 8443.4 8561.4 8564.0 8565.5 8128.4 8431.4 8489.1 8581.0 8581.5 7421.4 7479.4 7572.0 7573.7 7789.2 7575.1 7606.9 7655.5 7655.7 7678.6 7217.8 7232.5 7286.5 7290.5 7291.6 4983.3 5060.8 5068.9 5101.3 5125.6 5146.7 5256.7 5330.1 5442.3 5455.2 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#4] prototype.html Cycles:180 Average:4514.13 Median:5060.56 stddev:1323.94 (26.2%) stddev-sans-first:1289.83 07:06:15 INFO - PROCESS | 27967 | Values: 328.1 334.0 342.9 343.6 346.4 5074.7 5202.7 5232.9 5249.6 5250.5 5023.2 5151.3 5160.0 5177.8 5181.5 4101.7 4113.7 4115.9 4118.8 4123.4 3961.8 4079.9 4117.8 4129.5 4135.5 4013.7 4027.8 4031.2 4032.6 4039.6 4026.4 4030.7 4042.0 4057.7 4058.1 3566.8 3578.5 3591.1 3599.4 3601.8 5000.3 5060.4 5092.7 5123.7 5127.3 4609.6 4622.1 4628.3 4634.0 4638.0 5426.2 5428.5 5433.5 5434.5 5441.4 3801.3 3883.8 3898.9 3901.7 3909.0 5601.4 5640.5 5640.5 5640.7 5641.4 4047.5 4054.2 4058.0 4072.2 4104.5 3915.8 4093.8 4114.3 4147.2 4152.4 4618.7 4627.3 4629.8 4640.2 4643.8 5433.5 5465.5 5475.9 5479.5 5489.3 1315.8 1330.3 1407.4 1410.1 1413.3 888.5 902.2 916.8 917.7 918.5 4676.5 4710.8 4714.8 4726.4 4738.0 4923.7 4928.6 4939.3 4940.5 4957.5 4537.5 4645.9 4693.8 4702.9 4732.0 2608.9 2619.0 2628.6 2630.8 2647.8 5072.0 5085.8 5101.9 5120.1 5128.8 5033.6 5037.8 5040.4 5060.8 5419.7 5739.4 5781.6 5827.8 5832.7 5848.3 5563.0 5585.6 5586.6 5591.4 5597.4 5383.6 5484.4 5532.6 5548.5 5579.7 5719.3 5744.1 5805.1 5813.5 5815.2 4033.5 4050.8 4072.8 4094.1 4094.4 5380.6 5419.9 5612.2 5646.1 5652.5 5281.3 5421.0 5488.9 5504.3 5511.0 5462.3 5469.4 5517.0 5535.3 5536.0 5317.4 5479.8 5498.8 5501.4 5524.7 5486.9 5495.6 5496.4 5497.8 5562.8 5384.7 5402.3 5421.8 5423.3 5444.6 07:06:15 INFO - PROCESS | 27967 | 07:06:15 INFO - PROCESS | 27967 | [#5] yui.html Cycles:180 Average:20883.48 Median:2575.48 stddev:31460.76 (1221.5%) stddev-sans-first:31512.49 07:06:15 INFO - PROCESS | 27967 | Values: 694.3 705.3 727.7 753.3 786.0 13879.7 15335.9 16027.7 16072.1 16076.4 17055.1 17082.6 17087.8 17098.3 17277.4 774.6 794.6 796.1 797.2 798.5 653.9 678.0 768.4 791.4 801.1 818.8 820.0 821.2 823.5 824.5 824.5 825.1 826.6 827.3 827.4 504.3 518.7 519.2 521.8 591.8 13996.5 14598.8 14771.5 14786.7 14840.0 13505.5 13509.7 13674.4 14305.1 14441.6 11841.5 12416.6 12543.9 12557.9 12674.2 4294.2 4320.6 4350.9 4389.0 4488.6 82648.2 83658.0 85096.1 85197.1 85699.1 9844.2 9910.9 10025.3 10064.5 10648.1 18171.5 18268.9 18332.2 18384.3 18461.0 7245.4 7253.5 7326.2 7396.3 7427.4 4495.6 4552.4 4609.7 4636.3 4646.7 3231.1 3331.1 3337.2 3341.0 3342.7 583.9 594.2 601.9 611.9 624.1 568.8 588.2 589.4 622.4 627.9 8539.8 8634.5 8703.7 8860.2 8977.0 600.9 605.5 634.8 644.4 647.6 4097.6 4183.1 4211.7 4279.5 4288.3 112906.4 114178.0 116841.0 117898.0 120284.4 99890.0 100891.0 101018.0 104207.0 104578.5 92227.5 92822.5 93002.1 93169.5 93203.5 7961.8 8010.7 8045.6 8048.8 8266.1 53154.7 53224.0 53969.7 54061.5 54248.7 74066.3 75113.0 76559.2 77600.6 78602.6 9749.8 9818.8 10285.8 10569.0 10599.6 11124.8 11156.9 11167.6 11443.3 11569.6 10436.2 10694.5 10867.2 11229.4 11412.8 9689.6 10062.1 12037.1 12478.6 12524.2 12402.8 12547.6 12875.5 12887.1 12895.3 8924.1 9628.7 10290.7 10410.5 10586.4 9979.3 10462.0 10463.0 10834.9 10852.2 07:06:15 INFO - PROCESS | 27967 | -------- Summary: end -------- 07:06:15 INFO - PROCESS | 27967 | 07:06:16 INFO - TEST-INFO | 27967: exit 0 07:06:16 INFO - TEST-OK | dromaeo_css | took 1116472ms 07:06:16 INFO - TEST-START | kraken 07:06:16 INFO - operating with platform_type : linux_ 07:06:16 INFO - Initialising browser for kraken test... 07:06:16 INFO - TEST-INFO | started process 28273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWAo3k/profile http://localhost:33204/getInfo.html) 07:06:20 INFO - PROCESS | 28273 | __metrics Screen width/height:1600/1200 07:06:20 INFO - PROCESS | 28273 | colorDepth:24 07:06:20 INFO - PROCESS | 28273 | Browser inner width/height: 1024/697 07:06:20 INFO - PROCESS | 28273 | __metrics 07:06:21 INFO - PROCESS | 28273 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:06:21 INFO - PROCESS | 28273 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:21 INFO - PROCESS | 28273 | console.error: PushService: 07:06:21 INFO - PROCESS | 28273 | stateChangeProcessEnqueue: Error transitioning state 07:06:21 INFO - PROCESS | 28273 | UnknownError 07:06:22 INFO - TEST-INFO | 28273: exit 0 07:06:22 INFO - Browser initialized. 07:06:22 INFO - Running cycle 1/1 for kraken test... 07:06:22 INFO - TEST-INFO | started process 28357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWAo3k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:34 INFO - PROCESS | 28357 | RSS: Main: 174047232 07:06:34 INFO - PROCESS | 28357 | 07:06:37 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33204/tests/kraken/driver.html?testName=audio-beat-detection) 07:06:37 INFO - PROCESS | 28357 | RSS: Main: 233193472 07:06:37 INFO - PROCESS | 28357 | 07:06:40 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33204/tests/kraken/driver.html?testName=audio-dft) 07:06:41 INFO - PROCESS | 28357 | RSS: Main: 216760320 07:06:41 INFO - PROCESS | 28357 | 07:06:44 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33204/tests/kraken/driver.html?testName=audio-fft) 07:06:44 INFO - PROCESS | 28357 | RSS: Main: 298352640 07:06:44 INFO - PROCESS | 28357 | 07:06:47 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33204/tests/kraken/driver.html?testName=audio-oscillator) 07:06:47 INFO - PROCESS | 28357 | RSS: Main: 208490496 07:06:47 INFO - PROCESS | 28357 | 07:06:49 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:50 INFO - PROCESS | 28357 | RSS: Main: 213118976 07:06:50 INFO - PROCESS | 28357 | 07:06:53 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33204/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:53 INFO - PROCESS | 28357 | RSS: Main: 249344000 07:06:53 INFO - PROCESS | 28357 | 07:06:57 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33204/tests/kraken/driver.html?testName=imaging-desaturate) 07:06:57 INFO - PROCESS | 28357 | RSS: Main: 248520704 07:06:57 INFO - PROCESS | 28357 | 07:07:00 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33204/tests/kraken/driver.html?testName=json-parse-financial) 07:07:01 INFO - PROCESS | 28357 | RSS: Main: 248614912 07:07:01 INFO - PROCESS | 28357 | 07:07:02 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:03 INFO - PROCESS | 28357 | RSS: Main: 210202624 07:07:03 INFO - PROCESS | 28357 | 07:07:05 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:05 INFO - PROCESS | 28357 | RSS: Main: 218038272 07:07:05 INFO - PROCESS | 28357 | 07:07:07 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:08 INFO - PROCESS | 28357 | RSS: Main: 222638080 07:07:08 INFO - PROCESS | 28357 | 07:07:11 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:11 INFO - PROCESS | 28357 | RSS: Main: 224215040 07:07:11 INFO - PROCESS | 28357 | 07:07:14 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:15 INFO - PROCESS | 28357 | RSS: Main: 222543872 07:07:15 INFO - PROCESS | 28357 | 07:07:16 INFO - PROCESS | 28357 | Cycle 1(1): loaded http://localhost:33204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33204/tests/kraken/driver.html?testName=ai-astar) 07:07:16 INFO - PROCESS | 28357 | RSS: Main: 272613376 07:07:16 INFO - PROCESS | 28357 | 07:07:16 INFO - PROCESS | 28357 | __start_tp_report 07:07:16 INFO - PROCESS | 28357 | _x_x_mozilla_page_load 07:07:16 INFO - PROCESS | 28357 | _x_x_mozilla_page_load_details 07:07:16 INFO - PROCESS | 28357 | |i|pagename|runs| 07:07:16 INFO - PROCESS | 28357 | |0;ai-astar;109;109;111;110;112;110;112;112;111;112 07:07:16 INFO - PROCESS | 28357 | |1;audio-beat-detection;147;119;120;157;124;119;122;117;151;123 07:07:16 INFO - PROCESS | 28357 | |2;audio-dft;162;162;162;161;162;162;163;163;164;162 07:07:16 INFO - PROCESS | 28357 | |3;audio-fft;75;76;77;108;76;77;76;76;98;75 07:07:17 INFO - PROCESS | 28357 | |4;audio-oscillator;84;83;116;83;83;83;108;83;82;117 07:07:17 INFO - PROCESS | 28357 | |5;imaging-gaussian-blur;118;117;116;116;117;117;117;117;117;117 07:07:17 INFO - PROCESS | 28357 | |6;imaging-darkroom;147;146;147;148;148;147;147;147;149;146 07:07:17 INFO - PROCESS | 28357 | |7;imaging-desaturate;97;97;96;96;96;96;96;96;100;98 07:07:17 INFO - PROCESS | 28357 | |8;json-parse-financial;51;50;49;51;52;51;51;51;51;50 07:07:17 INFO - PROCESS | 28357 | |9;json-stringify-tinderbox;61;61;62;61;62;60;62;65;62;62 07:07:17 INFO - PROCESS | 28357 | |10;stanford-crypto-aes;81;78;88;82;79;79;80;80;84;78 07:07:17 INFO - PROCESS | 28357 | |11;stanford-crypto-ccm;142;126;122;122;129;133;125;122;162;124 07:07:17 INFO - PROCESS | 28357 | |12;stanford-crypto-pbkdf2;174;166;169;168;162;167;163;169;165;171 07:07:17 INFO - PROCESS | 28357 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;66;71;65;65;63 07:07:17 INFO - PROCESS | 28357 | __end_tp_report 07:07:17 INFO - PROCESS | 28357 | __start_cc_report 07:07:17 INFO - PROCESS | 28357 | _x_x_mozilla_cycle_collect,1646 07:07:17 INFO - PROCESS | 28357 | __end_cc_report 07:07:17 INFO - PROCESS | 28357 | __startTimestamp1474985236996__endTimestamp 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | ------- Summary: start ------- 07:07:17 INFO - PROCESS | 28357 | Number of tests: 14 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.23 (1.1%) stddev-sans-first:1.12 07:07:17 INFO - PROCESS | 28357 | Values: 109.0 109.0 111.0 110.0 112.0 110.0 112.0 112.0 111.0 112.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:123.50 stddev:15.34 (12.4%) stddev-sans-first:14.97 07:07:17 INFO - PROCESS | 28357 | Values: 147.0 119.0 120.0 157.0 124.0 119.0 122.0 117.0 151.0 123.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:07:17 INFO - PROCESS | 28357 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 163.0 163.0 164.0 162.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.64 (15.3%) stddev-sans-first:12.12 07:07:17 INFO - PROCESS | 28357 | Values: 75.0 76.0 77.0 108.0 76.0 77.0 76.0 76.0 98.0 75.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.00 stddev:15.00 (18.1%) stddev-sans-first:15.62 07:07:17 INFO - PROCESS | 28357 | Values: 84.0 83.0 116.0 83.0 83.0 83.0 108.0 83.0 82.0 117.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 07:07:17 INFO - PROCESS | 28357 | Values: 118.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:07:17 INFO - PROCESS | 28357 | Values: 147.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 149.0 146.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.32 (1.4%) stddev-sans-first:1.39 07:07:17 INFO - PROCESS | 28357 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 100.0 98.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 07:07:17 INFO - PROCESS | 28357 | Values: 51.0 50.0 49.0 51.0 52.0 51.0 51.0 51.0 51.0 50.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.36 07:07:17 INFO - PROCESS | 28357 | Values: 61.0 61.0 62.0 61.0 62.0 60.0 62.0 65.0 62.0 62.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:3.11 (3.9%) stddev-sans-first:3.30 07:07:17 INFO - PROCESS | 28357 | Values: 81.0 78.0 88.0 82.0 79.0 79.0 80.0 80.0 84.0 78.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:127.50 stddev:12.66 (9.9%) stddev-sans-first:12.75 07:07:17 INFO - PROCESS | 28357 | Values: 142.0 126.0 122.0 122.0 129.0 133.0 125.0 122.0 162.0 124.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.50 stddev:3.63 (2.2%) stddev-sans-first:2.96 07:07:17 INFO - PROCESS | 28357 | Values: 174.0 166.0 169.0 168.0 162.0 167.0 163.0 169.0 165.0 171.0 07:07:17 INFO - PROCESS | 28357 | 07:07:17 INFO - PROCESS | 28357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:2.07 (3.2%) stddev-sans-first:2.18 07:07:17 INFO - PROCESS | 28357 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 71.0 65.0 65.0 63.0 07:07:17 INFO - PROCESS | 28357 | -------- Summary: end -------- 07:07:17 INFO - PROCESS | 28357 | 07:07:18 INFO - TEST-INFO | 28357: exit 0 07:07:18 INFO - TEST-OK | kraken | took 61811ms 07:07:18 INFO - SUITE-END | took 1178s 07:07:18 INFO - Completed test suite (00:19:38) 07:07:18 INFO - javascript benchmark 07:07:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.376927729815, 3064.9999999999986, 3069.9079027629173, 3100.488419410797, 3112.7665425093123, 5287.365516138059, 5329.440408757083, 5365.785368585257, 5408.2158087077305, 5424.647397919142, 5372.838814835552, 5394.73026348682, 5409.323834520685, 5411.242426060345, 5413.485718856702, 4967.10592093423, 4967.155583550796, 4970.577500912426, 4980.800767969295, 5024.271480635306, 4960.107180707471, 4973.154563724175, 5050.7979680812905, 5055.696658200502, 5057.241413787924, 5040.042391945537, 5087.567556757662, 5107.4892510749, 5114.667546609477, 5117.1556693145585, 4934.9753251233515, 4980.551750342486, 4992.07646585381, 5001.649884508086, 5002.799888004475, 4790.473047964721, 4835.032993401333, 4847.175980083394, 4859.198232291667, 4872.902541949141, 5316.867078323035, 5323.574114070865, 5323.760430780624, 5336.706481143536, 5352.384475785296, 5798.101294299348, 5799.7100144993, 5802.854928626776, 5806.216160818278, 5806.477417032487, 5657.915131273035, 5680.602357834953, 5756.913646295309, 5778.855528611776, 5825.155352473867, 5395.919061214085, 5397.676139431607, 5413.918791218135, 5418.945810541923, 5476.780928762844, 5944.762209511658, 5954.255718035246, 5956.463918247378, 5956.821295361146, 5959.195508606369, 5527.917081243784, 5531.751071201806, 5581.10702287632, 5586.301712285965, 5734.885302293931, 5718.313802343745, 5737.139429085671, 5739.196512488255, 5803.129530570448, 5803.564732645069, 5723.0, 5728.05487094633, 5729.054705973551, 5733.3406658234, 5733.541316694738, 5600.159976003632, 5654.37801841797, 5736.368999410061, 5737.340205876294, 5794.652320860761, 4418.381426600278, 4419.337099435111, 4455.6658250631335, 4463.107378524308, 4512.481064677604, 3947.881563553098, 3949.7037722170953, 3968.206358728266, 3995.6403923647013, 4017.196560687874, 5388.137897936312, 5466.180072989004, 5513.531349835309, 5520.53075488588, 5532.889342213133, 5712.6286791358425, 5728.684922329228, 5769.423057694197, 5779.797707080316, 5870.14882841994, 5489.807856724996, 5518.2826232589505, 5518.862028449321, 5520.723963801794, 5523.25436066134, 5018.4981501849525, 5025.698458092453, 5031.6729412588065, 5036.143855544567, 5078.263651770547, 5864.618799778001, 5896.321922978912, 5926.0, 5959.791407300723, 5962.701864906824, 5770.884582308414, 5774.249347584787, 5775.1914731938405, 5780.595358325045, 5879.617824841372, 5963.135345374983, 5963.224780778471, 5967.254093238345, 5969.432903874125, 5969.52243820502, 5589.273394458694, 5599.132134519156, 5630.268065151504, 5657.066584013592, 5680.943190568207, 5794.681292528951, 5802.071668533014, 5807.448292412214, 5853.678047707417, 5871.794487192928, 5682.261306030189, 5687.260656114844, 5690.77236910519, 5691.630044047124, 5694.288213973254, 5483.259759932517, 5498.0, 5644.463775941279, 5654.943450565442, 5664.603477756682, 5659.151127330933, 5679.318481782213, 5689.6586204827845, 5753.8561535961935, 5759.136129580596, 5683.232763576864, 5701.059325211294, 5715.542756579547, 5721.542276617944, 5741.25363702716, 5379.273798037215, 5418.620696551204, 5489.039418101896, 5542.972285138549, 5548.916766248591], "value": 5333.6706529611865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8861336352021, 583.7168973048072, 611.4924612571565, 622.9937700622993, 638.5785381648113, 30447.08658740236, 41914.0, 42808.3578746319, 42941.14117717644, 43084.784576077116, 44145.55854441455, 44486.0, 44582.777086114605, 44679.0, 44730.0, 8127.75616731496, 8360.958195209016, 8919.866202006975, 9075.773105672344, 9078.273738100968, 10608.628697995571, 10848.29486083406, 10850.186236032328, 11216.887831121667, 11251.493682784254, 10977.28647637901, 11026.724331891686, 11046.779064418746, 11074.501647425845, 11082.778344433107, 10842.457877106153, 10894.400807955559, 10907.454627268684, 10910.61812836547, 10914.454277286104, 10676.145908327315, 10765.83851242232, 10766.300190487671, 10767.407792571405, 10776.67669969902, 41754.0, 42144.0, 42166.367504487454, 42202.57797422017, 42217.36673949893, 2973.7769667274824, 3096.612923384577, 3134.420132275536, 3267.0688853676825, 3283.868645254187, 31605.84197079, 32232.033039008867, 32252.6774732252, 32323.676763232535, 33140.0, 4240.363945408182, 4260.147970405931, 4358.389825424443, 4420.46954365475, 4560.498345182027, 325692.0, 327499.0, 328677.0, 329615.0, 329765.0, 55672.0, 56232.15651765145, 56570.0, 56590.7170464145, 56630.168491575256, 59180.40819591835, 59187.0, 59244.40755592475, 59261.0, 59298.40701592929, 14684.26578671062, 14851.480198193012, 14858.405663773328, 14860.479883204252, 14861.851381486047, 10002.799944001225, 10283.485825708685, 10293.74265643365, 10507.422091785025, 11526.538938442536, 15000.549983500512, 15935.760963585555, 16373.508794736177, 16376.590585235464, 16960.236789344508, 5740.799072032542, 6365.936340636627, 6461.57999730016, 6480.643564603898, 6496.967515162394, 945.6264775413811, 950.8288508068614, 1062.7821296634172, 1075.473018221066, 1096.819024860889, 27592.724072759014, 27625.447491050065, 27935.58096628552, 28037.579436308064, 28150.0, 1090.9399983000853, 1115.286216821235, 1123.0285802780536, 1130.4291332876844, 1136.3693150301663, 16156.676866462605, 16287.0, 16669.24988375526, 16806.831931680772, 16930.09800743151, 483851.0, 486226.0, 486953.0, 487318.0, 491248.0, 55995.44004559984, 56019.0, 56122.0, 56170.43829561652, 56267.0, 1283.826683397748, 1332.9000324975666, 1340.2427628389928, 1346.9461221551028, 1353.2163800963547, 29378.412431750818, 30824.69175308218, 31420.842895785376, 32386.676133238365, 32598.718997545857, 53513.732431337594, 54302.45697542974, 54319.45680543302, 54346.72826635841, 54349.45650543602, 419891.0, 421723.0, 423009.0, 423073.0, 423282.0, 22783.924170237467, 23240.767592324537, 27709.58435623427, 28178.2955426116, 28232.43535129245, 45964.310535342665, 46147.307790382496, 46315.305270421646, 46825.0, 46958.76520617375, 38710.2257954845, 38917.22165556729, 39268.60731392649, 39613.40579891246, 40914.38628420517, 38142.237155257295, 38200.426993595676, 39002.804985974886, 39540.40689389719, 40181.1963760729, 39605.80197098996, 39689.801550993216, 40123.598764011986, 40424.0, 40722.0, 33214.501782473766, 35796.284074317846, 36762.63237367592, 36804.26391472102, 36806.26387472182, 33872.49191262182, 34459.4831077529, 36444.27111457809, 36739.816300918326, 36860.0], "value": 19901.540924048004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.16772683958686, 401.5803485357803, 403.3747691078828, 404.56105125938365, 421.34901577063437, 13533.255670938095, 15536.067835929838, 19091.236350545998, 19463.610727785435, 19772.802271977274, 18791.906040469814, 18949.33677321294, 19299.80700193001, 19492.22031118757, 19499.12253948572, 5080.618953578478, 5657.094864821629, 5869.677167755772, 5872.8238152855265, 5876.0, 6385.968070159643, 6401.679916004181, 6451.354864513558, 6477.83805404864, 6487.318831522693, 6234.5324100692405, 6436.806895793134, 6460.160179176701, 6470.288268290485, 6512.088307636935, 6296.685165741695, 6523.05415714721, 6544.574602650812, 6560.868782624345, 6562.540622156451, 5675.3757086720425, 5716.142578613241, 5717.285339332583, 5719.456651618089, 5719.485246327808, 18824.717629235573, 19233.615327693507, 22864.77135228643, 22869.199578014857, 23076.4230894229, 2242.854214476054, 2350.6121489954307, 2402.243293362603, 2486.614574740918, 2984.5075562532156, 13539.59381218565, 14055.78916316256, 14095.506657266946, 14592.781108283278, 14995.925020374829, 1840.530664680498, 1909.0645583663904, 1924.5477312831474, 1932.9935170980382, 1968.6653268944315, 80639.0, 80975.30734580205, 82060.0, 82451.17548824554, 82592.58703706504, 10338.689839304832, 10408.167346612252, 10656.786864262827, 10855.023047925724, 11036.11711063113, 13903.235322057182, 13903.374348154357, 13906.51327203543, 13914.652133696536, 13918.791218131737, 7415.930702291799, 7589.810254743676, 7640.312371886557, 7682.078150621961, 7746.109197442253, 7071.116110486189, 7122.05308567352, 7133.89299160513, 7420.443466740016, 7449.515781474187, 6498.870022599522, 6508.902366464412, 6529.085927970088, 6546.509011824132, 6679.812791278078, 1844.9262029518668, 1864.0, 1884.6607610630217, 1895.1661269041579, 1947.4449781812116, 780.5277806926841, 852.6972924611797, 859.3082568532267, 925.3337596930199, 965.5510187762584, 17344.382728883964, 17663.0, 18158.90920545415, 18520.81479185191, 18541.258349666132, 891.460666296894, 896.4979611417627, 921.2767977137914, 935.1303287942143, 962.8411312133419, 9846.655367062262, 10468.895311046945, 10500.474976251156, 10582.100521455608, 10587.682369528926, 384184.0, 388154.0, 389167.0, 452452.0, 465648.0, 59200.703996479744, 64857.0, 93515.53242233745, 96456.51771741237, 97965.5101724501, 1019.1490105761624, 1030.1655658916302, 1054.6045233037612, 1060.3637817309552, 1073.7598074224127, 17686.557836054202, 17885.0, 18558.81441185571, 18566.907165464087, 18922.810771892655, 42301.78849105735, 42553.36169957515, 42585.29658813613, 42645.36031959585, 43790.56209437865, 58964.41035589589, 59026.70486647539, 59173.40826591679, 60539.69730151497, 60889.69555152196, 8419.466297843908, 8495.660173592987, 8523.105073967145, 8534.871976920474, 8612.311015118901, 9898.356606820533, 12322.32227227511, 12740.235585864877, 12890.613281601567, 13041.478340866259, 10842.674719758419, 11220.495077721358, 11292.43537823122, 11839.408029598659, 11857.5849845255, 11084.722881928017, 11170.385628790495, 11525.88474115248, 11603.6518904433, 11865.762684746083, 11318.32090074598, 11589.768204635691, 11946.940265298617, 12190.878091219329, 12208.0, 8592.957035214784, 8729.476231426135, 8822.33832462555, 8903.510306933182, 9052.90947090547, 10789.73025674333, 10928.0, 11006.779864402828, 11451.312921224753, 11607.419629018685], "value": 9235.857419776114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.129109623264, 1442.826860776707, 1451.0713143588102, 1597.0, 1785.4732853808118, 7941.483803552772, 8692.869606955894, 8993.235574976135, 9001.50491722955, 9226.308026897992, 8986.910130898688, 8999.640014399416, 9066.274698024159, 9076.727698169048, 9095.90904090959, 2320.6286994080906, 2347.3427440316655, 2352.8588284702887, 2354.0466111224982, 2355.634876594122, 2274.351809734226, 2323.465602911331, 2336.4392545788974, 2341.2976107167783, 2341.4614638633125, 2296.0586159674535, 2304.9654255186188, 2317.351141680332, 2336.0655737704883, 2336.170659415908, 2262.4570103175283, 2267.047839907243, 2270.3302525754775, 2273.9312523114195, 2275.260540324393, 2264.671622614728, 2305.8501197422283, 2308.953820923589, 2309.4226443389152, 2314.3866875278063, 8771.517566533901, 9018.0, 9067.909320906838, 9082.636694532277, 9083.772905677344, 5421.756020979065, 5565.165225216209, 5565.41563135873, 5574.86062848428, 5585.357683866367, 3678.0, 3682.355587772156, 3724.9813750931344, 3739.158689294914, 3740.233252183296, 1153.5097583527051, 1166.8133098704252, 1184.496588949693, 1198.6943329450935, 2000.3598848368529, 12250.203736757083, 12754.170978886435, 12789.104762666617, 12790.296533690644, 12800.359982000862, 4353.934690979638, 4680.578747912704, 4744.976275118603, 4795.992841503324, 4796.352492413549, 9336.0, 9339.906600933904, 9340.112689294507, 9350.438973661601, 9355.625774969061, 5371.355437347544, 5408.432114627986, 5409.053415652245, 5445.101558242845, 5452.073147564924, 4270.829166833292, 4403.119376124788, 4885.5358740919555, 4963.851084467472, 5002.89994200114, 3822.4839646647347, 3834.9233015339537, 3927.941080883732, 3964.365701487748, 3991.501062367204, 1220.5178954312996, 1227.9631611051682, 1232.057476030837, 1242.7203879127123, 1255.215490318551, 663.694700437804, 833.1834801894178, 943.3443756589242, 958.7459323279337, 962.2302158273353, 5897.5871688982215, 6017.1275165100815, 6051.304100028553, 6098.939010609926, 6163.106349579286, 442.61934736126904, 450.6935284006841, 452.80303068165455, 454.86354093771735, 596.0522768797632, 4091.5499295077516, 4133.524644665842, 4180.623743863006, 4188.267053265667, 4215.304474761691, 11014.779704405866, 11336.093112550976, 11444.798296178948, 11454.942725286486, 11468.139889508153, 11255.493502792395, 11295.887041129483, 11304.547818087349, 11305.71735706614, 11321.377324247082, 7902.723404680809, 8129.918700813035, 8202.220789025034, 8304.377171712025, 8321.417500774887, 5897.64614123154, 6280.371962803683, 6294.087357333069, 6323.905141422974, 6345.46063584582, 9940.0, 10511.842322365017, 10518.053375196268, 10536.10443112344, 10625.9468702656, 10785.892141078803, 10794.56821727122, 10796.784064318826, 10803.135749139892, 10804.567817287221, 8433.0, 8443.408961372645, 8561.400701950804, 8563.95718021406, 8565.48607083577, 8128.390370722102, 8431.367647426345, 8489.108643592333, 8581.0, 8581.485110893367, 7421.406287497095, 7479.439042071757, 7572.0, 7573.659185336563, 7789.221077892165, 7575.0909890813455, 7606.923930760621, 7655.50239234448, 7655.732049378245, 7678.577678227528, 7217.819554511179, 7232.529885557422, 7286.453515986216, 7290.4896657233485, 7291.562506249642, 4983.302337672656, 5060.772265247999, 5068.949310506848, 5101.285819985279, 5125.564327032244, 5146.6911985281, 5256.710880901587, 5330.093884039645, 5442.319710036246, 5455.236266922555], "value": 4619.435007484511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.05866460825933, 334.0279785823255, 342.9348423799478, 343.6065704768039, 346.42493460854985, 5074.746262686869, 5202.687838729674, 5232.895342093156, 5249.606279529036, 5250.474952504747, 5023.171176755831, 5151.278820965059, 5159.974200129003, 5177.844664660057, 5181.507756763111, 4101.662052630002, 4113.691473139512, 4115.917681646365, 4118.8146533406, 4123.36087906375, 3961.762294262339, 4079.8776036718946, 4117.79697861644, 4129.545749967501, 4135.524414692319, 4013.6989725770536, 4027.7784721840285, 4031.1736094100784, 4032.5765794591584, 4039.555648878621, 4026.416169655384, 4030.6775457963295, 4041.979790101045, 4057.6550993165615, 4058.1072164123843, 3566.7503274770775, 3578.481120237551, 3591.120175556979, 3599.3701102307255, 3601.8474088291755, 5000.3248911614655, 5060.368608323688, 5092.668976516515, 5123.666961647481, 5127.307813445174, 4609.608183304423, 4622.075584883037, 4628.305754136873, 4634.0, 4638.0, 5426.158945363475, 5428.511433970962, 5433.510984011458, 5434.510894019557, 5441.374241962186, 3801.346414309784, 3883.8446462141483, 3898.902527436837, 3901.6878649708237, 3908.9804550977065, 5601.383847776782, 5640.492355688008, 5640.520555752766, 5640.661560306395, 5641.379448260729, 4047.4535937648043, 4054.2499637567144, 4058.0, 4072.205919845661, 4104.507459104927, 3915.7846318452757, 4093.774842383638, 4114.341705327193, 4147.170565886835, 4152.37714342845, 4618.65360097994, 4627.329037289574, 4629.8148074077335, 4640.1879671058105, 4643.791029403685, 5433.538149257279, 5465.453454654582, 5475.946520054979, 5479.479449452296, 5489.258950041693, 1315.7828958221787, 1330.3414809669275, 1407.394820227312, 1410.0693542262059, 1413.2721648351107, 888.4757992784288, 902.1609902790468, 916.7937214126902, 917.7292698653913, 918.5407296351824, 4676.480143953228, 4710.788014539354, 4714.81140754366, 4726.409198850144, 4738.0, 4923.655344125877, 4928.556429921325, 4939.3084968104495, 4940.505949405031, 4957.504249575014, 4537.478190008125, 4645.86062418128, 4693.812247510062, 4702.882427939329, 4732.02993386355, 2608.9347766305996, 2618.9607155892677, 2628.6199745133576, 2630.763541135663, 2647.8411295321957, 5072.0, 5085.821996230115, 5101.8724531887, 5120.13115212952, 5128.794848206105, 5033.572146367526, 5037.848864534069, 5040.395152581714, 5060.761112887755, 5419.674819510842, 5739.368669446441, 5781.641314291054, 5827.825165245049, 5832.745959618617, 5848.2689663792025, 5563.02647036775, 5585.636933599303, 5586.636868603528, 5591.412901645269, 5597.440255974533, 5383.596230282823, 5484.396716361117, 5532.640378375554, 5548.500634942875, 5579.69311687861, 5719.28508936383, 5744.109663002241, 5805.129230615273, 5813.534917206529, 5815.2149459822385, 4033.515978082649, 4050.817713202972, 4072.75563466193, 4094.1402305516176, 4094.3653733671326, 5380.569554435714, 5419.891602168013, 5612.242347283064, 5646.124850648156, 5652.519535839499, 5281.33637904059, 5420.991349800898, 5488.926201327269, 5504.256925315031, 5511.0, 5462.262594549685, 5469.3983661797965, 5517.0, 5535.308086489189, 5536.0, 5317.388500322512, 5479.835604931858, 5498.835034948958, 5501.367342755474, 5524.723763811713, 5486.902619476041, 5495.587830912617, 5496.433516447793, 5497.790486093053, 5562.833115006556, 5384.703841288767, 5402.27069345649, 5421.82823048521, 5423.29497165366, 5444.6188766785945], "value": 4095.879125802576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.3056943056943, 705.3334598804131, 727.7271023366237, 753.2806170107547, 785.9646315915783, 13879.653008674775, 15335.923320383396, 16027.679446411064, 16072.11603361816, 16076.437324693637, 17055.147242637882, 17082.572935676613, 17087.82912170878, 17098.316067357322, 17277.395291164812, 774.6475353714046, 794.56696100625, 796.1441450440799, 797.2266901105918, 798.4769975665948, 653.9182602174728, 678.0236459498332, 768.4121646940096, 791.3550456378063, 801.0667572278318, 818.8403261364036, 820.0200760091693, 821.1788211788212, 823.4894365493402, 824.5341382119113, 824.4846970643318, 825.0759149752316, 826.557791581507, 827.3298628111219, 827.4497459189631, 504.27132793113964, 518.730260264664, 519.2211682476286, 521.8408385442439, 591.8283697727654, 13996.510122145675, 14598.781018284733, 14771.482998095122, 14786.704265914621, 14840.0, 13505.459781608724, 13509.662258443519, 13674.384652690653, 14305.05774591794, 14441.638959026004, 11841.467133978991, 12416.627501174979, 12543.874561254363, 12557.874421255854, 12674.176178548365, 4294.184105020036, 4320.6327462165755, 4350.934735978963, 4389.0, 4488.618467430272, 82648.17351826465, 83658.0, 85096.14903850944, 85197.14802851954, 85699.14300856974, 9844.212463002943, 9910.900890990997, 10025.348352357074, 10064.496775161213, 10648.14814814813, 18171.454856354332, 18268.908655456904, 18332.175052122686, 18384.26462941494, 18461.0, 7245.365756428187, 7253.528520646141, 7326.194118646945, 7396.297351751575, 7427.368673662691, 4495.595396414338, 4552.362669226311, 4609.746463944448, 4636.281376386665, 4646.697964632355, 3231.0952933178746, 3331.0506505645776, 3337.18239031434, 3340.9665903340656, 3342.7325813934826, 583.9299284085852, 594.197832925547, 601.9036954087325, 611.9235095613049, 624.0794827629302, 568.8208214412447, 588.2441063233724, 589.39586923403, 622.4273668225244, 627.8963970944834, 8539.786505337417, 8634.481931084156, 8703.695370662123, 8860.246879015227, 8977.0, 600.891839468891, 605.4702135631322, 634.8444631065419, 644.415232710989, 647.5661306924372, 4097.631213190827, 4183.142455796555, 4211.7472951623, 4279.465066866642, 4288.292431748727, 112906.43546782213, 114178.0, 116841.0, 117898.0, 120284.39857800656, 99890.0, 100891.0, 101018.0, 104207.0, 104578.47710761397, 92227.53886230526, 92822.53588732013, 93002.0699793007, 93169.53415233016, 93203.53398232965, 7961.840763184588, 8010.679572817022, 8045.597720114088, 8048.798780030546, 8266.13205613402, 53154.73422632862, 53224.00819938598, 53969.730151348995, 54061.459385407215, 54248.728756355966, 74066.25933740594, 75113.0, 76559.23440765744, 77600.61199693965, 78602.60698696699, 9749.805003900025, 9818.75453113678, 10285.794284114425, 10569.0, 10599.62901298451, 11124.833127502932, 11156.888431115585, 11167.553297868319, 11443.25618834773, 11569.595064172714, 10436.217283703905, 10694.465276736288, 10867.184961127788, 11229.438528073728, 11412.771744565229, 9689.563969621526, 10062.144717699077, 12037.097217708882, 12478.625641230778, 12524.248545087325, 12402.75194496123, 12547.623571292876, 12875.484980601046, 12887.097903147065, 12895.290759008345, 8924.107589241024, 9628.66299679508, 10290.691279261635, 10410.531526081193, 10586.417747023988, 9979.301448898508, 10462.0, 10463.0, 10834.945825270823, 10852.18608604342], "value": 7108.750599938151, "unit": "score"}], "name": "dromaeo_css", "value": 7134.457002957174, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 111.0, 110.0, 112.0, 110.0, 112.0, 112.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 120.0, 157.0, 124.0, 119.0, 122.0, 117.0, 151.0, 123.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0, 164.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 108.0, 76.0, 77.0, 76.0, 76.0, 98.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 83.0, 83.0, 83.0, 108.0, 83.0, 82.0, 117.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0, 98.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 60.0, 62.0, 65.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 88.0, 82.0, 79.0, 79.0, 80.0, 80.0, 84.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 126.0, 122.0, 122.0, 129.0, 133.0, 125.0, 122.0, 162.0, 124.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 166.0, 169.0, 168.0, 162.0, 167.0, 163.0, 169.0, 165.0, 171.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 71.0, 65.0, 65.0, 63.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1494.6000000000001, "alertThreshold": 2.0}]} 07:07:18 INFO - Return code: 0 07:07:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:07:18 INFO - # TBPL SUCCESS # 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - [mozharness: 2016-09-27 14:07:18.811105Z] Finished run-tests step (success) 07:07:18 INFO - Running post-run listener: _resource_record_post_run 07:07:18 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 392019968; Read time: 0; Write time: 252016 07:07:18 INFO - TinderboxPrint: CPU usage
13.1% 07:07:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:07:18 INFO - TinderboxPrint: I/O write bytes / time
392,019,968 / 252,016 07:07:18 INFO - TinderboxPrint: CPU idle
8,294.4 (86.9%) 07:07:18 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 07:07:18 INFO - TinderboxPrint: Swap in / out
0 / 0 07:07:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103833600; Read time: 0; Write time: 86568 07:07:18 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288186368; Read time: 0; Write time: 165448 07:07:19 INFO - Running post-run listener: _upload_blobber_files 07:07:19 INFO - Blob upload gear active. 07:07:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:07:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:07:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:23 INFO - (blobuploader) - INFO - Done attempting. 07:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:23 INFO - (blobuploader) - INFO - Done attempting. 07:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:24 INFO - (blobuploader) - INFO - Done attempting. 07:07:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:24 INFO - Return code: 0 07:07:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8685c2d2c8185bada93ea207705efb708a0e5b670b2adb9ccc5bc760e685679e52ee114830d4c1646bb7303572267f455b7bfd3a89ada2a3ea2ed6399d65b3ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3916e079e755366f0d1ad7e4a57b06af03acee2a3660a5b49fb8ee6386244de90c1b35d3bcdffbeb9d26a9c0c2b87fb064524b88ced6334812a146a96ff70760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e17d580943a897dd4a5f47876e059fa273e15c7999998fa254b32ff54b5bf500d10b38a2629e2e2ce2fb1577867586a563e833484152fc1917ca30a0e2fd114"} 07:07:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:24 INFO - Contents: 07:07:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8685c2d2c8185bada93ea207705efb708a0e5b670b2adb9ccc5bc760e685679e52ee114830d4c1646bb7303572267f455b7bfd3a89ada2a3ea2ed6399d65b3ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3916e079e755366f0d1ad7e4a57b06af03acee2a3660a5b49fb8ee6386244de90c1b35d3bcdffbeb9d26a9c0c2b87fb064524b88ced6334812a146a96ff70760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e17d580943a897dd4a5f47876e059fa273e15c7999998fa254b32ff54b5bf500d10b38a2629e2e2ce2fb1577867586a563e833484152fc1917ca30a0e2fd114"} 07:07:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:24 INFO - Copying logs to upload dir... 07:07:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.539733 ========= master_lag: 18.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-09-27 07:07:42.400266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:07:42.404180) ========= 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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8685c2d2c8185bada93ea207705efb708a0e5b670b2adb9ccc5bc760e685679e52ee114830d4c1646bb7303572267f455b7bfd3a89ada2a3ea2ed6399d65b3ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3916e079e755366f0d1ad7e4a57b06af03acee2a3660a5b49fb8ee6386244de90c1b35d3bcdffbeb9d26a9c0c2b87fb064524b88ced6334812a146a96ff70760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e17d580943a897dd4a5f47876e059fa273e15c7999998fa254b32ff54b5bf500d10b38a2629e2e2ce2fb1577867586a563e833484152fc1917ca30a0e2fd114"} build_url:https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/OojhGkOWQuelKDrw5HCqsw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8685c2d2c8185bada93ea207705efb708a0e5b670b2adb9ccc5bc760e685679e52ee114830d4c1646bb7303572267f455b7bfd3a89ada2a3ea2ed6399d65b3ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3916e079e755366f0d1ad7e4a57b06af03acee2a3660a5b49fb8ee6386244de90c1b35d3bcdffbeb9d26a9c0c2b87fb064524b88ced6334812a146a96ff70760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e17d580943a897dd4a5f47876e059fa273e15c7999998fa254b32ff54b5bf500d10b38a2629e2e2ce2fb1577867586a563e833484152fc1917ca30a0e2fd114"}' ========= master_lag: 0.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:07:42.650966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:07:42.651306) ========= 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=41a7e32711b8e08598a63237000001d6-1474984002.744185-1771509809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:07:42.692710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:07:42.693066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:07:42.699074) ========= ========= Total master_lag: 18.85 =========