builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1471965769.39 results: success (0) buildid: 20160823070147 builduid: 44e3ea43612d42de89d2379c46dfd383 revision: a522dde885298edd8701c5f2fbf61ccd80ce57f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.395031) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.395562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.395873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.410396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.410669) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 08:22:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.4M=0s 2016-08-23 08:22:49 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.586309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.586627) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015462 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:49.636450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 08:22:49.636808) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a522dde885298edd8701c5f2fbf61ccd80ce57f7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a522dde885298edd8701c5f2fbf61ccd80ce57f7 --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=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 08:22:49,903 truncating revision to first 12 chars 2016-08-23 08:22:49,903 Setting DEBUG logging. 2016-08-23 08:22:49,903 attempt 1/10 2016-08-23 08:22:49,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a522dde88529?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 08:22:50,608 unpacking tar archive at: mozilla-central-a522dde88529/testing/mozharness/ program finished with exit code 0 elapsedTime=1.033207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 08:22:50.685564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:50.686129) ========= script_repo_revision: a522dde885298edd8701c5f2fbf61ccd80ce57f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:50.686774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:50.687261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:22:50.698694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-23 08:22:50.698982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:51 INFO - MultiFileLogger online at 20160823 08:22:51 in /builds/slave/test 08:22:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:22:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:51 INFO - {'append_to_log': False, 08:22:51 INFO - 'base_work_dir': '/builds/slave/test', 08:22:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:22:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:51 INFO - 'branch': 'Firefox-Non-PGO', 08:22:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:51 INFO - 'config_files': ('talos/linux_config.py',), 08:22:51 INFO - 'default_actions': ('clobber', 08:22:51 INFO - 'read-buildbot-config', 08:22:51 INFO - 'download-and-extract', 08:22:51 INFO - 'populate-webroot', 08:22:51 INFO - 'create-virtualenv', 08:22:51 INFO - 'install', 08:22:51 INFO - 'run-tests'), 08:22:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:51 INFO - 'download_minidump_stackwalk': True, 08:22:51 INFO - 'download_symbols': 'ondemand', 08:22:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:51 INFO - 'installer_path': 'installer.exe', 08:22:51 INFO - 'log_level': 'info', 08:22:51 INFO - 'log_name': 'talos', 08:22:51 INFO - 'log_to_console': True, 08:22:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:51 INFO - 'opt_config_files': (), 08:22:51 INFO - 'pip_index': False, 08:22:51 INFO - 'sps_profile': False, 08:22:51 INFO - 'sps_profile_interval': 0, 08:22:51 INFO - 'suite': 'dromaeojs', 08:22:51 INFO - 'system_bits': '32', 08:22:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:51 INFO - 'title': 'talos-linux64-ix-037', 08:22:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:51 INFO - 'use_talos_json': True, 08:22:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:51 INFO - 'work_dir': 'build'} 08:22:51 INFO - [mozharness: 2016-08-23 15:22:51.058788Z] Running clobber step. 08:22:51 INFO - Running pre-action listener: _resource_record_pre_action 08:22:51 INFO - Running main action method: clobber 08:22:51 INFO - rmtree: /builds/slave/test/build 08:22:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:51 INFO - Running post-action listener: _resource_record_post_action 08:22:51 INFO - [mozharness: 2016-08-23 15:22:51.517905Z] Finished clobber step (success) 08:22:51 INFO - [mozharness: 2016-08-23 15:22:51.518006Z] Running read-buildbot-config step. 08:22:51 INFO - Running pre-action listener: _resource_record_pre_action 08:22:51 INFO - Running main action method: read_buildbot_config 08:22:51 INFO - Using buildbot properties: 08:22:51 INFO - { 08:22:51 INFO - "project": "", 08:22:51 INFO - "product": "firefox", 08:22:51 INFO - "script_repo_revision": "production", 08:22:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:22:51 INFO - "repository": "", 08:22:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:22:51 INFO - "buildid": "20160823070147", 08:22:51 INFO - "pgo_build": "False", 08:22:51 INFO - "basedir": "/builds/slave/test", 08:22:51 INFO - "buildnumber": 184, 08:22:51 INFO - "slavename": "talos-linux64-ix-037", 08:22:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:22:51 INFO - "platform": "ubuntu64_hw", 08:22:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:22:51 INFO - "branch": "mozilla-central", 08:22:51 INFO - "repo_path": "mozilla-central", 08:22:51 INFO - "revision": "a522dde885298edd8701c5f2fbf61ccd80ce57f7", 08:22:51 INFO - "stage_platform": "linux64", 08:22:51 INFO - "builduid": "44e3ea43612d42de89d2379c46dfd383", 08:22:51 INFO - "slavebuilddir": "test" 08:22:51 INFO - } 08:22:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:22:51 INFO - Running post-action listener: _resource_record_post_action 08:22:51 INFO - [mozharness: 2016-08-23 15:22:51.520441Z] Finished read-buildbot-config step (success) 08:22:51 INFO - [mozharness: 2016-08-23 15:22:51.520530Z] Running download-and-extract step. 08:22:51 INFO - Running pre-action listener: _resource_record_pre_action 08:22:51 INFO - Running main action method: download_and_extract 08:22:51 INFO - mkdir: /builds/slave/test/build/tests 08:22:51 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')]} 08:22:51 INFO - trying https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:51 INFO - Downloading https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:52 INFO - Downloaded 1361 bytes. 08:22:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:52 INFO - Using the following test package requirements: 08:22:52 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'jsshell-linux-x86_64.zip'], 08:22:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:52 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:52 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')]} 08:22:52 INFO - trying https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:52 INFO - Downloading https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:52 INFO - Downloaded 20331934 bytes. 08:22:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:22:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:22:57 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')]} 08:22:57 INFO - trying https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:57 INFO - Downloaded 20331934 bytes. 08:22:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:23: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')]} 08:23:02 INFO - trying https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:02 INFO - Downloading https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:03 INFO - Downloaded 14413981 bytes. 08:23:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:23: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')]} 08:23:03 INFO - trying https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:03 INFO - Downloading https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:04 INFO - Downloaded 55758677 bytes. 08:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:04 INFO - mkdir: /builds/slave/test/properties 08:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:04 INFO - Contents: 08:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - Running post-action listener: _resource_record_post_action 08:23:05 INFO - Running post-action listener: set_extra_try_arguments 08:23:05 INFO - [mozharness: 2016-08-23 15:23:05.292683Z] Finished download-and-extract step (success) 08:23:05 INFO - [mozharness: 2016-08-23 15:23:05.292908Z] Running populate-webroot step. 08:23:05 INFO - Running pre-action listener: _resource_record_pre_action 08:23:05 INFO - Running main action method: populate_webroot 08:23:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:05 INFO - '--tppagecycles', 08:23:05 INFO - '7'], 08:23:05 INFO - 'tests': ['tsvgm']}}, 08:23:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['damp', 'tps']}, 08:23:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['damp', 'tps']}, 08:23:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['dromaeo_dom']}, 08:23:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['basic_compositor_video']}, 08:23:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['a11yr', 08:23:05 INFO - 'ts_paint', 08:23:05 INFO - 'tpaint', 08:23:05 INFO - 'sessionrestore', 08:23:05 INFO - 'sessionrestore_no_auto_restore', 08:23:05 INFO - 'tabpaint']}, 08:23:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tsvgx', 08:23:05 INFO - 'tsvgr_opacity', 08:23:05 INFO - 'tart', 08:23:05 INFO - 'tscrollx', 08:23:05 INFO - 'cart']}, 08:23:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:05 INFO - 'tsvgr_opacity', 08:23:05 INFO - 'tart', 08:23:05 INFO - 'tscrollx', 08:23:05 INFO - 'cart']}, 08:23:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s'], 08:23:05 INFO - 'tests': ['tp5o']}, 08:23:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'tests': ['tp5o']}, 08:23:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--disable-e10s', 08:23:05 INFO - '--xperf_path', 08:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:05 INFO - 'tests': ['tp5n']}, 08:23:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:05 INFO - 'talos_options': ['--xperf_path', 08:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:05 INFO - 'tests': ['tp5n']}}, 08:23:05 INFO - 'talos.zip': {'path': '', 08:23:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:05 INFO - Running post-action listener: _resource_record_post_action 08:23:05 INFO - [mozharness: 2016-08-23 15:23:05.311377Z] Finished populate-webroot step (success) 08:23:05 INFO - [mozharness: 2016-08-23 15:23:05.311466Z] Running create-virtualenv step. 08:23:05 INFO - Running pre-action listener: _resource_record_pre_action 08:23:05 INFO - Running main action method: create_virtualenv 08:23:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:05 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 08:23:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:05 INFO - Using real prefix '/usr' 08:23:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:07 INFO - Installing pip.................done. 08:23:07 INFO - Return code: 0 08:23:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:07 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')]} 08:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:07 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')]} 08:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:07 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:07 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 08:23:07 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 08:23:07 INFO - Using env: {'DISPLAY': ':0', 08:23:07 INFO - 'HOME': '/home/cltbld', 08:23:07 INFO - 'LANG': 'en_US.UTF-8', 08:23:07 INFO - 'LANGUAGE': 'en_US:en', 08:23:07 INFO - 'LOGNAME': 'cltbld', 08:23:07 INFO - 'MAIL': '/var/mail/cltbld', 08:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:07 INFO - 'MOZ_NO_REMOTE': '1', 08:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:07 INFO - 'NO_EM_RESTART': '1', 08:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:07 INFO - 'PWD': '/builds/slave/test', 08:23:07 INFO - 'SHELL': '/bin/bash', 08:23:07 INFO - 'SHLVL': '1', 08:23:07 INFO - 'TERM': 'linux', 08:23:07 INFO - 'TMOUT': '86400', 08:23:07 INFO - 'USER': 'cltbld', 08:23:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:07 INFO - '_': '/tools/buildbot/bin/python'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 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 08:23:08 INFO - Cleaning up... 08:23:08 INFO - Return code: 0 08:23:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', '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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23: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 psutil>=3.1.1 08:23:08 INFO - Using env: {'DISPLAY': ':0', 08:23:08 INFO - 'HOME': '/home/cltbld', 08:23:08 INFO - 'LANG': 'en_US.UTF-8', 08:23:08 INFO - 'LANGUAGE': 'en_US:en', 08:23:08 INFO - 'LOGNAME': 'cltbld', 08:23:08 INFO - 'MAIL': '/var/mail/cltbld', 08:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:08 INFO - 'MOZ_NO_REMOTE': '1', 08:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:08 INFO - 'NO_EM_RESTART': '1', 08:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:08 INFO - 'PWD': '/builds/slave/test', 08:23:08 INFO - 'SHELL': '/bin/bash', 08:23:08 INFO - 'SHLVL': '1', 08:23:08 INFO - 'TERM': 'linux', 08:23:08 INFO - 'TMOUT': '86400', 08:23:08 INFO - 'USER': 'cltbld', 08:23:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:08 INFO - '_': '/tools/buildbot/bin/python'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 INFO - Downloading/unpacking psutil>=3.1.1 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:10 INFO - Installing collected packages: psutil 08:23:10 INFO - Running setup.py install for psutil 08:23:10 INFO - building 'psutil._psutil_linux' extension 08:23:10 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 08:23:10 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 08:23:10 INFO - building 'psutil._psutil_posix' extension 08:23:10 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 08:23:10 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 08:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:10 INFO - Successfully installed psutil 08:23:10 INFO - Cleaning up... 08:23:10 INFO - Return code: 0 08:23:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23: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 mozsystemmonitor==0.3 08:23:10 INFO - Using env: {'DISPLAY': ':0', 08:23:10 INFO - 'HOME': '/home/cltbld', 08:23:10 INFO - 'LANG': 'en_US.UTF-8', 08:23:10 INFO - 'LANGUAGE': 'en_US:en', 08:23:10 INFO - 'LOGNAME': 'cltbld', 08:23:10 INFO - 'MAIL': '/var/mail/cltbld', 08:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:10 INFO - 'MOZ_NO_REMOTE': '1', 08:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:10 INFO - 'NO_EM_RESTART': '1', 08:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:10 INFO - 'PWD': '/builds/slave/test', 08:23:10 INFO - 'SHELL': '/bin/bash', 08:23:10 INFO - 'SHLVL': '1', 08:23:10 INFO - 'TERM': 'linux', 08:23:10 INFO - 'TMOUT': '86400', 08:23:10 INFO - 'USER': 'cltbld', 08:23:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:10 INFO - '_': '/tools/buildbot/bin/python'} 08:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:13 INFO - Installing collected packages: mozsystemmonitor 08:23:13 INFO - Running setup.py install for mozsystemmonitor 08:23:13 INFO - Successfully installed mozsystemmonitor 08:23:13 INFO - Cleaning up... 08:23:13 INFO - Return code: 0 08:23:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:13 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')]} 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 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')]} 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:13 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:13 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 08:23:13 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 08:23:13 INFO - Using env: {'DISPLAY': ':0', 08:23:13 INFO - 'HOME': '/home/cltbld', 08:23:13 INFO - 'LANG': 'en_US.UTF-8', 08:23:13 INFO - 'LANGUAGE': 'en_US:en', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MAIL': '/var/mail/cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SHLVL': '1', 08:23:13 INFO - 'TERM': 'linux', 08:23:13 INFO - 'TMOUT': '86400', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - '_': '/tools/buildbot/bin/python'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:15 INFO - warning: no files found matching '*.txt' 08:23:15 INFO - no previously-included directories found matching 'build' 08:23:15 INFO - no previously-included directories found matching 'dist' 08:23:15 INFO - no previously-included directories found matching '.git*' 08:23:15 INFO - Installing collected packages: jsonschema, functools32 08:23:15 INFO - Running setup.py install for functools32 08:23:15 INFO - warning: no files found matching '*.txt' 08:23:15 INFO - no previously-included directories found matching 'build' 08:23:15 INFO - no previously-included directories found matching 'dist' 08:23:15 INFO - no previously-included directories found matching '.git*' 08:23:15 INFO - Successfully installed jsonschema functools32 08:23:15 INFO - Cleaning up... 08:23:15 INFO - Return code: 0 08:23:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:23:15 INFO - Using env: {'DISPLAY': ':0', 08:23:15 INFO - 'HOME': '/home/cltbld', 08:23:15 INFO - 'LANG': 'en_US.UTF-8', 08:23:15 INFO - 'LANGUAGE': 'en_US:en', 08:23:15 INFO - 'LOGNAME': 'cltbld', 08:23:15 INFO - 'MAIL': '/var/mail/cltbld', 08:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:15 INFO - 'MOZ_NO_REMOTE': '1', 08:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:15 INFO - 'NO_EM_RESTART': '1', 08:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:15 INFO - 'PWD': '/builds/slave/test', 08:23:15 INFO - 'SHELL': '/bin/bash', 08:23:15 INFO - 'SHLVL': '1', 08:23:15 INFO - 'TERM': 'linux', 08:23:15 INFO - 'TMOUT': '86400', 08:23:15 INFO - 'USER': 'cltbld', 08:23:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:15 INFO - '_': '/tools/buildbot/bin/python'} 08:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:15 INFO - Cleaning up... 08:23:16 INFO - Return code: 0 08:23:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:16 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')]} 08:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 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')]} 08:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:16 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 08:23:16 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 08:23:16 INFO - Using env: {'DISPLAY': ':0', 08:23:16 INFO - 'HOME': '/home/cltbld', 08:23:16 INFO - 'LANG': 'en_US.UTF-8', 08:23:16 INFO - 'LANGUAGE': 'en_US:en', 08:23:16 INFO - 'LOGNAME': 'cltbld', 08:23:16 INFO - 'MAIL': '/var/mail/cltbld', 08:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:16 INFO - 'MOZ_NO_REMOTE': '1', 08:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:16 INFO - 'NO_EM_RESTART': '1', 08:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:16 INFO - 'PWD': '/builds/slave/test', 08:23:16 INFO - 'SHELL': '/bin/bash', 08:23:16 INFO - 'SHLVL': '1', 08:23:16 INFO - 'TERM': 'linux', 08:23:16 INFO - 'TMOUT': '86400', 08:23:16 INFO - 'USER': 'cltbld', 08:23:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:16 INFO - '_': '/tools/buildbot/bin/python'} 08:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - Downloading docopt-0.6.1.tar.gz 08:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:18 INFO - Running setup.py install for blobuploader 08:23:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:18 INFO - Running setup.py install for requests 08:23:19 INFO - Running setup.py install for docopt 08:23:19 INFO - Successfully installed blobuploader requests docopt 08:23:19 INFO - Cleaning up... 08:23:19 INFO - Return code: 0 08:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:19 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')]} 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:19 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')]} 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:19 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:19 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 08:23:19 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 08:23:19 INFO - Using env: {'DISPLAY': ':0', 08:23:19 INFO - 'HOME': '/home/cltbld', 08:23:19 INFO - 'LANG': 'en_US.UTF-8', 08:23:19 INFO - 'LANGUAGE': 'en_US:en', 08:23:19 INFO - 'LOGNAME': 'cltbld', 08:23:19 INFO - 'MAIL': '/var/mail/cltbld', 08:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:19 INFO - 'MOZ_NO_REMOTE': '1', 08:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:19 INFO - 'NO_EM_RESTART': '1', 08:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:19 INFO - 'PWD': '/builds/slave/test', 08:23:19 INFO - 'SHELL': '/bin/bash', 08:23:19 INFO - 'SHLVL': '1', 08:23:19 INFO - 'TERM': 'linux', 08:23:19 INFO - 'TMOUT': '86400', 08:23:19 INFO - 'USER': 'cltbld', 08:23:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:19 INFO - '_': '/tools/buildbot/bin/python'} 08:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:19 INFO - Running setup.py (path:/tmp/pip-hILq3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:19 INFO - Running setup.py (path:/tmp/pip-Jzj21K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Running setup.py (path:/tmp/pip-zPyShn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 INFO - Running setup.py (path:/tmp/pip-Cvuw5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:19 INFO - Running setup.py (path:/tmp/pip-L7tKc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:20 INFO - Running setup.py (path:/tmp/pip-vNgmYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:20 INFO - Running setup.py (path:/tmp/pip-0aHGhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:20 INFO - Running setup.py (path:/tmp/pip-2cun96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:20 INFO - Running setup.py (path:/tmp/pip-O6tIUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:20 INFO - Running setup.py (path:/tmp/pip-yOAOP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 INFO - Running setup.py (path:/tmp/pip-hRIJKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 INFO - Running setup.py (path:/tmp/pip-EmKzgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Running setup.py (path:/tmp/pip-3G1CRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Running setup.py (path:/tmp/pip-bH3QX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Running setup.py (path:/tmp/pip-Q1flsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Running setup.py (path:/tmp/pip-Ho54YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Running setup.py (path:/tmp/pip-549jN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:20 INFO - Running setup.py install for manifestparser 08:23:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozcrash 08:23:21 INFO - Running setup.py install for mozdebug 08:23:21 INFO - Running setup.py install for mozdevice 08:23:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozfile 08:23:21 INFO - Running setup.py install for mozhttpd 08:23:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozinfo 08:23:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozInstall 08:23:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for mozleak 08:23:21 INFO - Running setup.py install for mozlog 08:23:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:21 INFO - Running setup.py install for moznetwork 08:23:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozprocess 08:23:22 INFO - Running setup.py install for mozprofile 08:23:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozrunner 08:23:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozscreenshot 08:23:22 INFO - Running setup.py install for moztest 08:23:22 INFO - Running setup.py install for mozversion 08:23:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:22 INFO - Cleaning up... 08:23:22 INFO - Return code: 0 08:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:22 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:22 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 08:23:22 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 08:23:22 INFO - Using env: {'DISPLAY': ':0', 08:23:22 INFO - 'HOME': '/home/cltbld', 08:23:22 INFO - 'LANG': 'en_US.UTF-8', 08:23:22 INFO - 'LANGUAGE': 'en_US:en', 08:23:22 INFO - 'LOGNAME': 'cltbld', 08:23:22 INFO - 'MAIL': '/var/mail/cltbld', 08:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:22 INFO - 'MOZ_NO_REMOTE': '1', 08:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:22 INFO - 'NO_EM_RESTART': '1', 08:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:22 INFO - 'PWD': '/builds/slave/test', 08:23:22 INFO - 'SHELL': '/bin/bash', 08:23:22 INFO - 'SHLVL': '1', 08:23:22 INFO - 'TERM': 'linux', 08:23:22 INFO - 'TMOUT': '86400', 08:23:22 INFO - 'USER': 'cltbld', 08:23:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:22 INFO - '_': '/tools/buildbot/bin/python'} 08:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:22 INFO - Running setup.py (path:/tmp/pip-vMYX5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:23 INFO - Running setup.py (path:/tmp/pip-BEyx8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:23 INFO - Running setup.py (path:/tmp/pip-8blVqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:23 INFO - Running setup.py (path:/tmp/pip-XTJzNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:23 INFO - Running setup.py (path:/tmp/pip-blcM5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:23 INFO - Running setup.py (path:/tmp/pip-MBYUlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:23 INFO - Running setup.py (path:/tmp/pip-dijMT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:23 INFO - Running setup.py (path:/tmp/pip-4tVqCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:23 INFO - Running setup.py (path:/tmp/pip-xGd1b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:23 INFO - Running setup.py (path:/tmp/pip-UXXyEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:23 INFO - Running setup.py (path:/tmp/pip-Y03hY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:23 INFO - Running setup.py (path:/tmp/pip-FTyeFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:23 INFO - Running setup.py (path:/tmp/pip-9QDaS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:23 INFO - Running setup.py (path:/tmp/pip-IUa_Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:23 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)) 08:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:23 INFO - Running setup.py (path:/tmp/pip-Qumd2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:24 INFO - Running setup.py (path:/tmp/pip-gp60dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:24 INFO - Running setup.py (path:/tmp/pip-GVbDEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:24 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)) 08:23:24 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)) 08:23:24 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)) 08:23:24 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)) 08:23:24 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)) 08:23:24 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)) 08:23:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:26 INFO - Downloading blessings-1.6.tar.gz 08:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:26 INFO - Installing collected packages: blessings 08:23:26 INFO - Running setup.py install for blessings 08:23:26 INFO - Successfully installed blessings 08:23:26 INFO - Cleaning up... 08:23:26 INFO - Return code: 0 08:23:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:26 INFO - Reading from file tmpfile_stdout 08:23:26 INFO - Current package versions: 08:23:26 INFO - argparse == 1.2.1 08:23:26 INFO - blessings == 1.6 08:23:26 INFO - blobuploader == 1.2.4 08:23:26 INFO - docopt == 0.6.1 08:23:26 INFO - functools32 == 3.2.3-2 08:23:26 INFO - jsonschema == 2.5.1 08:23:26 INFO - manifestparser == 1.1 08:23:26 INFO - mozInstall == 1.12 08:23:26 INFO - mozcrash == 0.17 08:23:26 INFO - mozdebug == 0.1 08:23:26 INFO - mozdevice == 0.48 08:23:26 INFO - mozfile == 1.2 08:23:26 INFO - mozhttpd == 0.7 08:23:26 INFO - mozinfo == 0.9 08:23:26 INFO - mozleak == 0.1 08:23:26 INFO - mozlog == 3.3 08:23:26 INFO - moznetwork == 0.27 08:23:26 INFO - mozprocess == 0.23 08:23:26 INFO - mozprofile == 0.28 08:23:26 INFO - mozrunner == 6.12 08:23:26 INFO - mozscreenshot == 0.1 08:23:26 INFO - mozsystemmonitor == 0.3 08:23:26 INFO - moztest == 0.7 08:23:26 INFO - mozversion == 1.4 08:23:26 INFO - psutil == 3.1.1 08:23:26 INFO - requests == 1.2.3 08:23:26 INFO - wsgiref == 0.1.2 08:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 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 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:26 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 08:23:26 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 08:23:26 INFO - Using env: {'DISPLAY': ':0', 08:23:26 INFO - 'HOME': '/home/cltbld', 08:23:26 INFO - 'LANG': 'en_US.UTF-8', 08:23:26 INFO - 'LANGUAGE': 'en_US:en', 08:23:26 INFO - 'LOGNAME': 'cltbld', 08:23:26 INFO - 'MAIL': '/var/mail/cltbld', 08:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:26 INFO - 'MOZ_NO_REMOTE': '1', 08:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:26 INFO - 'NO_EM_RESTART': '1', 08:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:26 INFO - 'PWD': '/builds/slave/test', 08:23:26 INFO - 'SHELL': '/bin/bash', 08:23:26 INFO - 'SHLVL': '1', 08:23:26 INFO - 'TERM': 'linux', 08:23:26 INFO - 'TMOUT': '86400', 08:23:26 INFO - 'USER': 'cltbld', 08:23:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:26 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 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)) 08:23:26 INFO - Cleaning up... 08:23:26 INFO - Return code: 0 08:23:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32e772ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', '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 08:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:26 INFO - Using env: {'DISPLAY': ':0', 08:23:26 INFO - 'HOME': '/home/cltbld', 08:23:26 INFO - 'LANG': 'en_US.UTF-8', 08:23:26 INFO - 'LANGUAGE': 'en_US:en', 08:23:26 INFO - 'LOGNAME': 'cltbld', 08:23:26 INFO - 'MAIL': '/var/mail/cltbld', 08:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:26 INFO - 'MOZ_NO_REMOTE': '1', 08:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:26 INFO - 'NO_EM_RESTART': '1', 08:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:26 INFO - 'PWD': '/builds/slave/test', 08:23:26 INFO - 'SHELL': '/bin/bash', 08:23:26 INFO - 'SHLVL': '1', 08:23:26 INFO - 'TERM': 'linux', 08:23:26 INFO - 'TMOUT': '86400', 08:23:26 INFO - 'USER': 'cltbld', 08:23:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:26 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:26 INFO - Cleaning up... 08:23:27 INFO - Return code: 0 08:23:27 INFO - Running post-action listener: _resource_record_post_action 08:23:27 INFO - Running post-action listener: _start_resource_monitoring 08:23:27 INFO - Starting resource monitoring. 08:23:27 INFO - [mozharness: 2016-08-23 15:23:27.040071Z] Finished create-virtualenv step (success) 08:23:27 INFO - [mozharness: 2016-08-23 15:23:27.040570Z] Running install step. 08:23:27 INFO - Running pre-action listener: _resource_record_pre_action 08:23:27 INFO - Running main action method: install 08:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:27 INFO - Reading from file tmpfile_stdout 08:23:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:27 INFO - Reading from file tmpfile_stdout 08:23:27 INFO - Output received: 08:23:27 INFO - Usage: mozinstall [options] installer 08:23:27 INFO - Options: 08:23:27 INFO - -h, --help show this help message and exit 08:23:27 INFO - -d DEST, --destination=DEST 08:23:27 INFO - Directory to install application into. [default: 08:23:27 INFO - "/builds/slave/test"] 08:23:27 INFO - --app=APP Application being installed. [default: firefox] 08:23:27 INFO - mkdir: /builds/slave/test/build/application 08:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:43 INFO - Reading from file tmpfile_stdout 08:23:43 INFO - Output received: 08:23:43 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:43 INFO - Running post-action listener: _resource_record_post_action 08:23:43 INFO - [mozharness: 2016-08-23 15:23:43.424924Z] Finished install step (success) 08:23:43 INFO - [mozharness: 2016-08-23 15:23:43.425227Z] Running run-tests step. 08:23:43 INFO - Running pre-action listener: _resource_record_pre_action 08:23:43 INFO - Running main action method: run_tests 08:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:43 INFO - Python 2.7.3 08:23:43 INFO - Return code: 0 08:23:43 INFO - grabbing minidump binary from tooltool 08:23:43 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')]} 08:23:43 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 0x1cf9090>, '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 0x1cfc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:43 INFO - Return code: 0 08:23:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:23:43 INFO - Using env: {'DISPLAY': ':0', 08:23:43 INFO - 'HOME': '/home/cltbld', 08:23:43 INFO - 'LANG': 'en_US.UTF-8', 08:23:43 INFO - 'LANGUAGE': 'en_US:en', 08:23:43 INFO - 'LOGNAME': 'cltbld', 08:23:43 INFO - 'MAIL': '/var/mail/cltbld', 08:23:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:43 INFO - 'MOZ_NO_REMOTE': '1', 08:23:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:43 INFO - 'NO_EM_RESTART': '1', 08:23:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:43 INFO - 'PWD': '/builds/slave/test', 08:23:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:43 INFO - 'SHELL': '/bin/bash', 08:23:43 INFO - 'SHLVL': '1', 08:23:43 INFO - 'TERM': 'linux', 08:23:43 INFO - 'TMOUT': '86400', 08:23:43 INFO - 'USER': 'cltbld', 08:23:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191', 08:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:43 INFO - '_': '/tools/buildbot/bin/python'} 08:23:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:23:43 INFO - mozversion application_buildid: 20160823070147 08:23:43 INFO - mozversion application_changeset: a522dde885298edd8701c5f2fbf61ccd80ce57f7 08:23:43 INFO - mozversion application_display_name: Nightly 08:23:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:43 INFO - mozversion application_name: Firefox 08:23:43 INFO - mozversion application_remotingname: firefox 08:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:23:43 INFO - mozversion application_vendor: Mozilla 08:23:43 INFO - mozversion application_version: 51.0a1 08:23:43 INFO - mozversion platform_buildid: 20160823070147 08:23:43 INFO - mozversion platform_changeset: a522dde885298edd8701c5f2fbf61ccd80ce57f7 08:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:23:43 INFO - mozversion platform_version: 51.0a1 08:23:43 INFO - using testdate: 1471965823 08:23:43 INFO - actual date: 1471965823 08:23:43 INFO - starting webserver on 'localhost:42123' 08:23:43 INFO - SUITE-START | Running 2 tests 08:23:43 INFO - TEST-START | dromaeo_css 08:23:43 INFO - operating with platform_type : linux_ 08:23:43 INFO - Initialising browser for dromaeo_css test... 08:23:43 INFO - TEST-INFO | started process 15029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5p5ha/profile http://localhost:42123/getInfo.html) 08:23:47 INFO - PROCESS | 15029 | __metrics Screen width/height:1600/1200 08:23:47 INFO - PROCESS | 15029 | colorDepth:24 08:23:47 INFO - PROCESS | 15029 | Browser inner width/height: 1024/697 08:23:47 INFO - PROCESS | 15029 | __metrics 08:23:48 INFO - PROCESS | 15029 | 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" 08:23:48 INFO - PROCESS | 15029 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:48 INFO - PROCESS | 15029 | console.error: PushService: 08:23:48 INFO - PROCESS | 15029 | stateChangeProcessEnqueue: Error transitioning state 08:23:48 INFO - PROCESS | 15029 | UnknownError 08:23:49 INFO - TEST-INFO | 15029: exit 0 08:23:49 INFO - Browser initialized. 08:23:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:49 INFO - TEST-INFO | started process 15109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5p5ha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:01 INFO - PROCESS | 15109 | RSS: Main: 174809088 08:24:01 INFO - PROCESS | 15109 | 08:24:52 INFO - PROCESS | 15109 | 1471965892778 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] 08:27:05 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42123/tests/dromaeo/cssquery-ext.html) 08:27:06 INFO - PROCESS | 15109 | RSS: Main: 266203136 08:27:06 INFO - PROCESS | 15109 | 08:30:09 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-ext.html (next: http://localhost:42123/tests/dromaeo/cssquery-jquery.html) 08:30:09 INFO - PROCESS | 15109 | RSS: Main: 272109568 08:30:09 INFO - PROCESS | 15109 | 08:33:12 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42123/tests/dromaeo/cssquery-mootools.html) 08:33:12 INFO - PROCESS | 15109 | RSS: Main: 220209152 08:33:12 INFO - PROCESS | 15109 | 08:36:15 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42123/tests/dromaeo/cssquery-prototype.html) 08:36:15 INFO - PROCESS | 15109 | RSS: Main: 218902528 08:36:15 INFO - PROCESS | 15109 | 08:39:19 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42123/tests/dromaeo/cssquery-yui.html) 08:39:19 INFO - PROCESS | 15109 | RSS: Main: 218804224 08:39:19 INFO - PROCESS | 15109 | 08:42:22 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:42123/tests/dromaeo/cssquery-yui.html (next: http://localhost:42123/tests/dromaeo/cssquery-dojo.html) 08:42:23 INFO - PROCESS | 15109 | RSS: Main: 311033856 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | __start_tp_report 08:42:23 INFO - PROCESS | 15109 | _x_x_mozilla_page_load 08:42:23 INFO - PROCESS | 15109 | _x_x_mozilla_page_load_details 08:42:23 INFO - PROCESS | 15109 | |i|pagename|runs| 08:42:23 INFO - PROCESS | 15109 | |0;dojo.html;2552.9361765955855;2594.2995391244353;2600.1549496413663;2603.0889188783917;2608.061098004719;4506.143832671798;4522.706024108431;4582.656300777442;4679.0174063446675;4688.437387513494;4568.269076947689;4590.839320623779;4592.563706447882;4596.241620132674;4675.555822196894;4202.432671589342;4218.767967761772;4341.261985462464;4362.105768317488;4379.64962802975;4347.130573885235;4377.255866502686;4379.08039311745;4387.583179597933;4388.056567837914;4166.749995000279;4223.831046758126;4266.1254442839145;4309.655227581786;4312.439382880206;4178.101708132735;4205.095904380542;4210.031692710693;4240.787960601989;4325.653947684209;4190.664746820247;4211.7051806373565;4217.514985776614;4226.535081141072;4232.449781528381;4449.688521803475;4597.60920321773;4600.194965880991;4608.953910460886;4619.907601847978;5008.499150084962;5022.397312322508;5040.5463508284065;5044.117279476113;5044.142495775727;5023.070731914608;5040.269160971675;5067.138586440314;5082.23766435034;5085.364329458817;4464.866054018385;4621.768911554409;4651.86044418668;4661.930071048937;4714.6464015199;5148.768305426265;5166.276721259027;5166.9224961625605;5170.819021334235;5171.663841850268;4965.652404331734;4967.3294105296045;4970.2793095001025;4976.875578110504;4978;4818.855434336975;4928.802847886044;4943.851684449401;4969.503049695001;5052.444231134572;4972.229304457815;5010.774515146827;5011.423686276052;5014.348134742533;5014.498550145029;4982.053409852117;4986.800527978913;4998.700077995332;5002.59979201663;5004.874878128076;4089.7750623715983;4120.526139493936;4126.360414135814;4163.458750362433;4237.703360764778;3665.9633403666157;3671.853125874935;3691.9815400922826;3732.738708290448;3783.905402364963;4398.846040388571;4402.3836662867225;4406.603405693503;4410.933835992462;4416.381706561084;5037.874053148627;5051.2423136529815;5051.924221136685;5052.090623687772;5054.873628159326;4220.831166753357;4258.127083947783;4312.288472402019;4314.115606300701;4381.627561657231;4486.910261794746;4489.6408287336935;4492.124035812985;4501.189785838515;4508.797104130322;4697.4832768395445;4721.527847215251;4744.667873248977;4758.333833263277;4763.309320148628;4829.179039563212;4916.631252655993;4941.752912354296;4956.207006878882;5040.143175660073;4736.73947932867;4736.952630473651;4748.074125545623;4759.857204283877;4763.857084287477;4940.184869496637;4942.036302920896;4944.28307895346;4949.901001979868;4950.034743225036;4774.30772537987;4888.071266459361;4911.263310503453;4936.975315123402;5019.272205530251;4847.854564363075;4885.5358740919555;4886.853394398174;4889.877753056202;4915.21356582945;4868.853934381974;4888.682235654671;4891.755412229445;4895.583875370491;4897.191963326154;4647.55848194421;4760.238361862085;4791.6406269529225;4806.567408933212;4854.368932038812;4924.803007879788;4945.703257804544;4971.726555039508;4982.302477653059;4985.177445721561;4827.565519103297;4833.782479788348;4840.177169881058;4843.346148269939;4847.830325938575 08:42:23 INFO - PROCESS | 15109 | |1;ext.html;540.3650710415262;557.620817843866;560.817734236373;567.2823877794589;576.2537513919474;39300.803495982516;40713.79643101784;40981.385279220834;44287;44417;39829.80085099571;40429.79785101078;40478.392824107665;40499;40501;7685.961570192155;7827.608619569027;7834.647440865147;7842.72550460734;7843.254890785366;7739.419543534257;7823.960880195619;7833.804154896145;7836.333911617491;7837.921620783776;7888.7633370998965;7916.40626952978;7923.8415231695335;7925.2867241948215;7926.445148839583;7828.217178282183;7836.216378362146;7870.803229919241;7871.527708337518;7873.173316801768;7719.459637825355;7798.649060792278;7799.8440031199625;7800.141984381714;7803.063632364153;38166.61833381659;38444.615553844385;38504.614953850665;38522;38526.42210366847;2415.3478560788662;2521.722610512842;2563.384787650969;2598.2724837045657;2628.9191059683335;28586.285342866595;28663.426731465253;28952.42095158085;29109.41781164386;29989.100326990225;3294.58817647794;3329.1344250494803;3377.9662203378143;3382.4926261061037;3443.6212016678146;262720.6863965687;263714;264020;264164;264547;46431.30353044707;46606.76696616563;46674.76662616665;46679.29981050287;46684.5331546687;48149.518504815205;53352;54877.72561137249;55312.17031744527;55404;12965.740685186243;13284.867151328557;13307;13345.532906348231;13352.599422017354;9897.406155630686;9948.154406875497;9965.20278377728;10001.849972250422;10029.147522460527;14274.857251427353;15488.612784680248;16274.26765795542;16289.592760180853;16307.83692163087;5915.911261331084;6101.389861013952;6107.816765497042;6112.786052488142;6171.105189747462;786.5084322298563;880.0363601855958;882.580774132282;902.1835239108617;906.5875026862761;27094;27815;28110.578341324897;28280.575791363146;28557.428851422854;918.3433844800866;985.1576901749045;1002.1331548210891;1028.5680014393972;1038.6883934819523;13918.443262269599;14995.400183992519;15045.623859403384;15117.16855572932;15283.694326113415;372356;377634;378236;378444.8321892615;378611;48709.512904871204;48804.755976219894;48825.75587122042;48910.510894891304;49007;1123.3091648636193;1173.3253379306932;1175.0188592525337;1176.8293597428326;1178.793711100571;26085.869570652027;26904.73095269022;27223.59164612493;27594.172174834788;27746.583801242592;36927.07682307964;37012.44481332836;37046.44430333601;37087.44368834416;37095.62904370922;260619;262853;263243;263316;263348;30979.535306969963;37122.628773713;37860.62139378571;37941.62058379381;38006.61993380141;30953.139487886812;35950;36345.27511423498;45590.54409455863;45918;35384.64615353814;35832.64167358293;35840.10399740027;35901.82049089738;36366.63633363633;35597.46603800893;35642.821785890905;35810;35900.82049589735;36404.635953641184;35756.64243357533;36605.26789464142;37198.62801371951;38632.80683596564;39125.41311880267;30230;31639.367212656078;32746.1813454656;33060.87556428661;33482.497762533094;24795.610370399783;25400.618990714785;25814.870925645253;25847;25944.351391214615 08:42:23 INFO - PROCESS | 15109 | |2;jquery.html;360.6033363300368;373.48086160237267;376.58199398667483;376.7358177354104;385.56431232707035;16247;17115.40096096637;17407.39074132404;17483.475495735147;17493.125343732794;15297.388104475835;15778.842211577881;16568.66862662746;16610.25253863576;16700.415485458012;4979.8008079676765;5234.031704134747;5237.240600112981;5240.737963101829;5246.029484545371;3752.81235938202;3989.2819292527333;5053.444121146689;5775.162601422791;6041.426064523863;6138.969305153468;6147.538934579924;6152.169457123298;6154.415330543591;6162.952298109332;5909.881802363951;6055.091736239578;6076.6354018758575;6085.878282434326;6088.573799834014;5079.3650793650795;5176.663516871391;5283.577313814885;5289.788408463657;5292.126799078147;19025.80974190268;19893.20427182911;20936;21133.04901279446;21147.47131321714;1941.6116776644728;1979.9041215845193;2099.968500472479;2171.7502487214015;2396.700412448444;9230.307726920508;9342.299327550392;12646.241225526497;12679.619611411581;13012.284324362156;1680.4790514940407;1708.6924353616344;1743.1632816248145;1776.875618706691;1779.6262784815203;68222.8465538881;68728.65635671839;69500.6524967372;69765;70041.64979175072;10126.44304563256;10153.898461015295;10380.844287335696;10439.269251152346;10623.52194151265;13989.510367137102;13999.44002239899;14004.649883752783;14007.299635018207;14015.929920350332;6889.448844092461;7007.789766307019;7145.464090193256;7292;7310;6709.6367256026415;6720.563163394364;6842.886486648563;6863.142107236596;6925.065116209247;4297.484301883794;4378.605925466723;4392.38506609075;4501.549845015472;4537.977310113428;1574.826769055403;1632.991835040841;1689.1300979995312;1806.2684612731864;1885.1139964216795;761.919998400171;802.1216767639426;825.8513467575774;850.6980022092068;868.4485351801525;15510.146941918078;15590.610234744223;16752.329906803592;16838.158092095346;17551.29794808219;795.2365728900205;808.6644042722204;823.5593957232852;858.6737039924789;884.960176792033;9114.270858331318;9747;9790.118889299998;9799.167070799062;9858.359206651545;414403;417595;418067;443555;446746;48180;48841;49521.75239123854;77944.61027694939;79528.602356989;871.9441721650857;874.6894852327332;897.0804924951846;906.7370462565914;907.9228265597499;15773.29020194117;16304.347826086823;16580.025992202533;16783.832161678227;17100.486985390457;28365.71634283631;36339.90980270596;37357.25285494329;37984.43023354707;38118;51359;51620.48379516157;52392;54093;54565;7692.34615057704;7846.725364612211;7850.411219158472;8013.959930200312;8091.797705057421;9927.602895884083;9988.300818942604;11812.70468238301;12003.279803211835;12642;6516.413522782972;6973.267806880407;9810.018998100133;9840.11438970496;10155;6806.591604503746;10109.898901011189;10178.694639160836;10260.486975651038;10293.485325733833;10002.649907253211;10080.344777589433;10087.546060427445;10115.7471063224;10272.178225742073;7481.962590187014;7675.961620191863;7682.807929801576;7814.296713295831;7847.646855891385;9654.855177172207;9998.25013124004;10055.296129271173;10143.49282535885;10285.588576456857 08:42:23 INFO - PROCESS | 15109 | |3;mootools.html;1343.5997109466498;1376.7108907129502;1425.914445133292;1643.654832485178;1671.1644177911044;6704.932950670492;7018.087648605674;7426.851462970737;8083.555404452753;8090.190980901907;7258.963705181467;7494.812629684247;7541.509801862875;7702.922970770291;7744.496607720508;2122.639151344275;2145.2277180215187;2145.871247725134;2147.7852214778554;2161.3083813179787;1819.7725284339458;2109.862858914166;2112.535242246703;2139.368886178581;2204.096320508592;2110.9788902110936;2126.1601667341392;2131;2145.1526646974435;2145.356393082077;2077.45986043629;2082.4481512399225;2114.450242936832;2118.8834614096218;2123.2568600989684;2040.3271714054488;2059.577786553753;2062.7215325930956;2067.286786058822;2100.411884672294;7987.840243195162;8058.476199047043;8060.395470339748;8071.112177660452;8092.757217283432;4280.700350975433;4399.868003959887;4401.097774956126;4420.46954365475;4424.269995450747;2741.300968253103;2876.741093301592;2899.6230490036373;2904.2739315171207;2920.4305160493714;878.4553576782436;885.2254277507182;891.8305521950808;898.2813749000774;900.9234215091725;10849.67450976472;10876.673699789018;10877.12982961369;10878.456077196188;10908.34549927007;3963.7621742694955;4012.4783778109245;4145.585441455831;4165.125323682;4204.285271503852;8459.873101903477;8615.655373784979;8625.654973800978;8632.438891472035;8636.784080397914;4421.756803375781;4432.601065904084;4435.645148388121;4436.26801577736;4443.622292105208;3990.2019596080318;4116.320807066801;4144.772037537904;4147.979260103741;4150.896227594334;3233.337165880989;3304.3391321735267;3330.0342900559053;3348.7655864089766;3384.543086683266;929.9816700712709;957.9425234485954;958.166395236149;967.7435479597913;981.5239608789731;685.6434653979902;711.210556282526;733.5012191709689;736.5911918885071;752.6876346316218;5077.39071311445;5384.5692344612335;5393.649412788156;5474.644148130438;5578.63738856973;835.4527784301292;859.4499520307008;860.7347199616554;863.8747381629754;909.5634095634133;3473.6873681368797;3581.8746343877838;3586.1751797086818;3667.331364229323;3745;9414.858777118348;9831.459269740233;9889.109980101824;9892.109710126124;9923.751906202402;9631;9820.607175713034;9848.06443387877;9851.261155413373;9880.209583233323;7310.268973102754;7445.664945077485;7453.590052547053;7454.030975973197;7464.925350746423;5168.715720635401;5226.503482169188;5278.683279003272;5286.20706893969;5389.7035663038905;8848.955755221183;8922.776930576787;8932.553372331227;9042.502662353634;9086;9163.587638556148;9209.585568649292;9243.142608911505;9294.442333460014;9320.114589114024;6026.0659597762415;6189.9690501549;6191.690415479118;6191.81424557264;6196.318404975359;7308.671109799965;7322.0847394075745;7390.408767298711;7390.815229619303;7409.481336306407;5598.916016259678;5784.450477204827;6583.242927063257;6680.365365290289;6684.398404143456;6530.510211734234;6604.273529911802;6663.533552651268;6665.866682666417;6679.265280819203;6246.187995560548;6332.651704156316;6355.428011478804;6364.840878978062;6366.586171898812;4450.310201918708;4667.066586682609;4689.366935463669;4733.881652958566;4748.928766068442;4434;4559.726416415026;4677.485476597503;4744.644151688568;4782.067496838084 08:42:23 INFO - PROCESS | 15109 | |4;prototype.html;301.09670987038885;308.2540252588735;311.10402042118704;313.61268832991266;314.9811011339321;4687.414073240845;4748.786304616292;4750.881227969294;4771.35586695796;4783.210770222913;4716.90566188676;4719.126961512123;4721.575058244757;4725.527447255281;4732.858014259569;3593.730470214731;3655.6161603031696;3686.152184997452;3732.3654978653694;3781.678557322617;3760.236226373613;3768.586779957516;3775.4903088083033;3780.9621903780885;3790.3556395412847;3733.551973763152;3736.831842567091;3740.906477338061;3747.6627103560672;3753.493278407421;3536.9115772105647;3603.405438102723;3732.925341493155;3744.2324323513612;3748.4939533162947;3337.2324365396094;3349.2631621043333;3350.8219657223;3356.56364672591;3358.6473420290763;4621.260598304255;4642.466116396624;4644.419447569054;4646.512116227781;4653.0228651983125;4174.624283814441;4247.87256382309;4272.87181384559;4277.935830962538;4301.505326887417;4927.285543596195;4946.851594452172;4957.950420495785;4962.15643340633;4969;3659.8170091495317;3663.3955397359405;3669.321175582526;3670.082479380155;3675.7059435245114;4891.951080489221;5197.818076367347;5202.947970520322;5207.203514787392;5211.609129315317;3576.123849656851;3635.563732352082;3636.6726994570618;3639.5996440391536;3649.6532829381167;3683.5211422514903;3684.6868016218923;3685.244524872395;3692.7415080944074;3693.7045036397026;4194.832206711759;4202.936955945664;4208.116295577963;4210.179015092028;4213.52526615682;4691;4983.152864013126;4985.252212168131;4995.150824359867;5006.774695138727;1284.9871501285054;1292.8125421813784;1295.3652710171948;1296.371259938929;1297.3902265934996;808.4987307869159;822.7531740477833;829.5313148071441;845.6236974546391;846.5090247656344;4331.263685173528;4468.776561171993;4473.561908759733;4474.955250447519;4480.372747815309;5111.97444012785;5129.9230511542355;5131.79472821083;5134.486551344836;5141.177411614199;4474.485434175046;4474.7762611869275;4479.552044795494;4482.260427029503;4482.686211965196;2586.8059895507913;2728.577070554067;2741.766205207625;2744.7804175665897;2748.6151938728594;4892.828750993698;4902.583280421204;4907.1903135982875;4909.828156014522;4913.754312284372;5046.44489106198;5285.497877701612;5287.127623942083;5298.258243845865;5308.389535203501;4866.7079975200895;4914.655974081851;4920.261960705851;4924.138275801721;4928.6057115431395;5178.223266510054;5188.9622075585785;5197.272381866466;5208.401033881152;5214.843554693365;4872.147374209429;5049.394072711299;5087.414947280962;5100.795968161232;5111.386633603991;4901.632377571767;4907.68100073494;4911.3369695090705;4912.95087049125;4928.211486162197;3635.2729454108753;3643.544556930384;3662.7619204751604;3667.5782285036494;3669.321175582526;4896.975515122402;5185.27406163145;5189.636725429184;5194.3247377840635;5199.220116982483;4965.677230979974;5028.773705183348;5057.280524621499;5064.4935506449065;5065.721385323843;5033.634191929787;5044.520770526794;5044.596432285482;5053.84838454847;5061.822836200715;4864.951350486592;4973.179425394914;4990.750462476789;4994.951060277383;5017.974910125572;4901.926471103007;4974.328465657235;5071.467495912876;5090.371081253963;5099.949000509948;4972.353594032753;4977.178765503651;4983.352164218773;4983.551480366785;4989.625778066587 08:42:23 INFO - PROCESS | 15109 | |5;yui.html;527.0670912484904;546.1071148671921;557.2171099605054;572.661344865548;618.7092066728636;11369.829452558208;12352.50589976401;12384.876151238484;12415.130940834133;12429.067819913498;11856.525738970453;12141.392930353491;12438.751224975495;12460.688482787935;12581.496740130407;747.4468893019167;769.3191525499944;771.5602106799126;771.8687823070092;773.0838955837322;616.0574321288414;737.8524295140967;762.7368557847561;766.1916677904808;770.218228498075;814.0313027497289;814.7800093974623;816.808050108224;816.967321307147;817.5094943034162;806.1293802693077;806.2340776262574;806.6571707024491;807.5074204735107;807.9394045446586;474.96912700674693;482.5150723522837;486.0352200881248;488.8069212660979;564.802319188285;11316.773664526745;11700.239484433485;11761.353125578089;11774.705632359259;11780.941095294555;11745.4714537846;12375.876241237562;12410.193337433127;12500.8124878126;12866.742665146645;10464.162866970624;10680.679579612624;10785.083267922237;10935.83596246057;11013.724656883562;3776.3013842439236;3791.5071040764524;3801.3917773156163;3806.2768074066116;3948.6446219840354;65086.3491365085;65454.67272663654;66082.66958665175;66905;70490.94263586102;9197.712320275166;9206.677766278148;9450;9509.952450237704;9561.713148605553;16803.579910502336;17073;17076.743848842278;17086.743698844526;17104.401345952832;6326.936730632635;6328.303886572473;6364.872702546016;6474.514411419163;6694.732210711614;3389.457686770105;3558.5551806024246;3591.245838373971;3648.427838507649;3749.5500539934837;2655.6282120503147;2748.477789220082;2755.641766570373;2760.875760590778;2781.735735105162;457.7185031205784;462.2834606360128;462.90973260213934;468.5806203447895;474.71042663974947;478.18230825289146;479.41990191867535;485.23090900921727;498.75810232037435;500.5095006893192;7489.625518724151;7581.848363032708;7783.182765809622;7891.638975398274;8044.477108988014;471.25541644202076;479.09451137350436;491.91391506486224;497.60689055646355;514.5626217714912;3595.3528364894046;3618.3306088373733;3707.870224542128;3817.5800661927165;3819.961800382016;103845;106569;107486.46256768666;108102;111898;74279;90871;91139;92458;93697.53151234337;79860.20139798528;81391.99999999882;81634.18365816266;83306.58346708228;83654;7318.377937875341;7445.4043676506835;7498.287662672037;7527.435442341737;7545.886811697938;48330;48729;49115.508844912525;50223;50326;66303.33696662972;71373;71835;72073.6396318015;73827;8897.599608017525;8971.192592666692;8998.955005224932;9072.637094516145;9090.818183636422;9590.184834289164;9612.807743845224;9715.70852874415;9763.56063977137;9941.900580994386;9370.484623345781;9457;9464;9468.905310946802;9749.415035097916;9797.461139637388;10130.8480372793;10138.594456221963;10152.949235253776;10223.335483193569;9202.585883635387;9544.618215271588;9571.61713531451;9626.32615716893;9936.006399360296;7469.178390377163;7586.886196706943;7672.769816905502;7701.1143718473095;7755.3407960324;7918.604069796372;8080.757577272691;8142.307903828241;8142.959285203536;8547.91452085496 08:42:23 INFO - PROCESS | 15109 | __end_tp_report 08:42:23 INFO - PROCESS | 15109 | __start_cc_report 08:42:23 INFO - PROCESS | 15109 | _x_x_mozilla_cycle_collect,978 08:42:23 INFO - PROCESS | 15109 | __end_cc_report 08:42:23 INFO - PROCESS | 15109 | __startTimestamp1471966943181__endTimestamp 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | ------- Summary: start ------- 08:42:23 INFO - PROCESS | 15109 | Number of tests: 6 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#0] dojo.html Cycles:165 Average:4614.18 Median:4758.33 stddev:494.27 (10.4%) stddev-sans-first:468.59 08:42:23 INFO - PROCESS | 15109 | Values: 2552.9 2594.3 2600.2 2603.1 2608.1 4506.1 4522.7 4582.7 4679.0 4688.4 4568.3 4590.8 4592.6 4596.2 4675.6 4202.4 4218.8 4341.3 4362.1 4379.6 4347.1 4377.3 4379.1 4387.6 4388.1 4166.7 4223.8 4266.1 4309.7 4312.4 4178.1 4205.1 4210.0 4240.8 4325.7 4190.7 4211.7 4217.5 4226.5 4232.4 4449.7 4597.6 4600.2 4609.0 4619.9 5008.5 5022.4 5040.5 5044.1 5044.1 5023.1 5040.3 5067.1 5082.2 5085.4 4464.9 4621.8 4651.9 4661.9 4714.6 5148.8 5166.3 5166.9 5170.8 5171.7 4965.7 4967.3 4970.3 4976.9 4978.0 4818.9 4928.8 4943.9 4969.5 5052.4 4972.2 5010.8 5011.4 5014.3 5014.5 4982.1 4986.8 4998.7 5002.6 5004.9 4089.8 4120.5 4126.4 4163.5 4237.7 3666.0 3671.9 3692.0 3732.7 3783.9 4398.8 4402.4 4406.6 4410.9 4416.4 5037.9 5051.2 5051.9 5052.1 5054.9 4220.8 4258.1 4312.3 4314.1 4381.6 4486.9 4489.6 4492.1 4501.2 4508.8 4697.5 4721.5 4744.7 4758.3 4763.3 4829.2 4916.6 4941.8 4956.2 5040.1 4736.7 4737.0 4748.1 4759.9 4763.9 4940.2 4942.0 4944.3 4949.9 4950.0 4774.3 4888.1 4911.3 4937.0 5019.3 4847.9 4885.5 4886.9 4889.9 4915.2 4868.9 4888.7 4891.8 4895.6 4897.2 4647.6 4760.2 4791.6 4806.6 4854.4 4924.8 4945.7 4971.7 4982.3 4985.2 4827.6 4833.8 4840.2 4843.3 4847.8 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#1] ext.html Cycles:180 Average:45701.53 Median:37109.13 stddev:80376.55 (216.6%) stddev-sans-first:80530.51 08:42:23 INFO - PROCESS | 15109 | Values: 540.4 557.6 560.8 567.3 576.3 39300.8 40713.8 40981.4 44287.0 44417.0 39829.8 40429.8 40478.4 40499.0 40501.0 7686.0 7827.6 7834.6 7842.7 7843.3 7739.4 7824.0 7833.8 7836.3 7837.9 7888.8 7916.4 7923.8 7925.3 7926.4 7828.2 7836.2 7870.8 7871.5 7873.2 7719.5 7798.6 7799.8 7800.1 7803.1 38166.6 38444.6 38504.6 38522.0 38526.4 2415.3 2521.7 2563.4 2598.3 2628.9 28586.3 28663.4 28952.4 29109.4 29989.1 3294.6 3329.1 3378.0 3382.5 3443.6 262720.7 263714.0 264020.0 264164.0 264547.0 46431.3 46606.8 46674.8 46679.3 46684.5 48149.5 53352.0 54877.7 55312.2 55404.0 12965.7 13284.9 13307.0 13345.5 13352.6 9897.4 9948.2 9965.2 10001.8 10029.1 14274.9 15488.6 16274.3 16289.6 16307.8 5915.9 6101.4 6107.8 6112.8 6171.1 786.5 880.0 882.6 902.2 906.6 27094.0 27815.0 28110.6 28280.6 28557.4 918.3 985.2 1002.1 1028.6 1038.7 13918.4 14995.4 15045.6 15117.2 15283.7 372356.0 377634.0 378236.0 378444.8 378611.0 48709.5 48804.8 48825.8 48910.5 49007.0 1123.3 1173.3 1175.0 1176.8 1178.8 26085.9 26904.7 27223.6 27594.2 27746.6 36927.1 37012.4 37046.4 37087.4 37095.6 260619.0 262853.0 263243.0 263316.0 263348.0 30979.5 37122.6 37860.6 37941.6 38006.6 30953.1 35950.0 36345.3 45590.5 45918.0 35384.6 35832.6 35840.1 35901.8 36366.6 35597.5 35642.8 35810.0 35900.8 36404.6 35756.6 36605.3 37198.6 38632.8 39125.4 30230.0 31639.4 32746.2 33060.9 33482.5 24795.6 25400.6 25814.9 25847.0 25944.4 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#2] jquery.html Cycles:180 Average:24952.03 Median:26358.99 stddev:70267.96 (266.6%) stddev-sans-first:70440.82 08:42:23 INFO - PROCESS | 15109 | Values: 360.6 373.5 376.6 376.7 385.6 16247.0 17115.4 17407.4 17483.5 17493.1 15297.4 15778.8 16568.7 16610.3 16700.4 4979.8 5234.0 5237.2 5240.7 5246.0 3752.8 3989.3 5053.4 5775.2 6041.4 6139.0 6147.5 6152.2 6154.4 6163.0 5909.9 6055.1 6076.6 6085.9 6088.6 5079.4 5176.7 5283.6 5289.8 5292.1 19025.8 19893.2 20936.0 21133.0 21147.5 1941.6 1979.9 2100.0 2171.8 2396.7 9230.3 9342.3 12646.2 12679.6 13012.3 1680.5 1708.7 1743.2 1776.9 1779.6 68222.8 68728.7 69500.7 69765.0 70041.6 10126.4 10153.9 10380.8 10439.3 10623.5 13989.5 13999.4 14004.6 14007.3 14015.9 6889.4 7007.8 7145.5 7292.0 7310.0 6709.6 6720.6 6842.9 6863.1 6925.1 4297.5 4378.6 4392.4 4501.5 4538.0 1574.8 1633.0 1689.1 1806.3 1885.1 761.9 802.1 825.9 850.7 868.4 15510.1 15590.6 16752.3 16838.2 17551.3 795.2 808.7 823.6 858.7 885.0 9114.3 9747.0 9790.1 9799.2 9858.4 414403.0 417595.0 418067.0 443555.0 446746.0 48180.0 48841.0 49521.8 77944.6 79528.6 871.9 874.7 897.1 906.7 907.9 15773.3 16304.3 16580.0 16783.8 17100.5 28365.7 36339.9 37357.3 37984.4 38118.0 51359.0 51620.5 52392.0 54093.0 54565.0 7692.3 7846.7 7850.4 8014.0 8091.8 9927.6 9988.3 11812.7 12003.3 12642.0 6516.4 6973.3 9810.0 9840.1 10155.0 6806.6 10109.9 10178.7 10260.5 10293.5 10002.6 10080.3 10087.5 10115.7 10272.2 7482.0 7676.0 7682.8 7814.3 7847.6 9654.9 9998.3 10055.3 10143.5 10285.6 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#3] mootools.html Cycles:180 Average:5076.58 Median:5691.68 stddev:2911.49 (51.2%) stddev-sans-first:2906.14 08:42:23 INFO - PROCESS | 15109 | Values: 1343.6 1376.7 1425.9 1643.7 1671.2 6704.9 7018.1 7426.9 8083.6 8090.2 7259.0 7494.8 7541.5 7702.9 7744.5 2122.6 2145.2 2145.9 2147.8 2161.3 1819.8 2109.9 2112.5 2139.4 2204.1 2111.0 2126.2 2131.0 2145.2 2145.4 2077.5 2082.4 2114.5 2118.9 2123.3 2040.3 2059.6 2062.7 2067.3 2100.4 7987.8 8058.5 8060.4 8071.1 8092.8 4280.7 4399.9 4401.1 4420.5 4424.3 2741.3 2876.7 2899.6 2904.3 2920.4 878.5 885.2 891.8 898.3 900.9 10849.7 10876.7 10877.1 10878.5 10908.3 3963.8 4012.5 4145.6 4165.1 4204.3 8459.9 8615.7 8625.7 8632.4 8636.8 4421.8 4432.6 4435.6 4436.3 4443.6 3990.2 4116.3 4144.8 4148.0 4150.9 3233.3 3304.3 3330.0 3348.8 3384.5 930.0 957.9 958.2 967.7 981.5 685.6 711.2 733.5 736.6 752.7 5077.4 5384.6 5393.6 5474.6 5578.6 835.5 859.4 860.7 863.9 909.6 3473.7 3581.9 3586.2 3667.3 3745.0 9414.9 9831.5 9889.1 9892.1 9923.8 9631.0 9820.6 9848.1 9851.3 9880.2 7310.3 7445.7 7453.6 7454.0 7464.9 5168.7 5226.5 5278.7 5286.2 5389.7 8849.0 8922.8 8932.6 9042.5 9086.0 9163.6 9209.6 9243.1 9294.4 9320.1 6026.1 6190.0 6191.7 6191.8 6196.3 7308.7 7322.1 7390.4 7390.8 7409.5 5598.9 5784.5 6583.2 6680.4 6684.4 6530.5 6604.3 6663.5 6665.9 6679.3 6246.2 6332.7 6355.4 6364.8 6366.6 4450.3 4667.1 4689.4 4733.9 4748.9 4434.0 4559.7 4677.5 4744.6 4782.1 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#4] prototype.html Cycles:180 Average:4168.87 Median:4729.19 stddev:1208.51 (25.6%) stddev-sans-first:1176.52 08:42:23 INFO - PROCESS | 15109 | Values: 301.1 308.3 311.1 313.6 315.0 4687.4 4748.8 4750.9 4771.4 4783.2 4716.9 4719.1 4721.6 4725.5 4732.9 3593.7 3655.6 3686.2 3732.4 3781.7 3760.2 3768.6 3775.5 3781.0 3790.4 3733.6 3736.8 3740.9 3747.7 3753.5 3536.9 3603.4 3732.9 3744.2 3748.5 3337.2 3349.3 3350.8 3356.6 3358.6 4621.3 4642.5 4644.4 4646.5 4653.0 4174.6 4247.9 4272.9 4277.9 4301.5 4927.3 4946.9 4958.0 4962.2 4969.0 3659.8 3663.4 3669.3 3670.1 3675.7 4892.0 5197.8 5202.9 5207.2 5211.6 3576.1 3635.6 3636.7 3639.6 3649.7 3683.5 3684.7 3685.2 3692.7 3693.7 4194.8 4202.9 4208.1 4210.2 4213.5 4691.0 4983.2 4985.3 4995.2 5006.8 1285.0 1292.8 1295.4 1296.4 1297.4 808.5 822.8 829.5 845.6 846.5 4331.3 4468.8 4473.6 4475.0 4480.4 5112.0 5129.9 5131.8 5134.5 5141.2 4474.5 4474.8 4479.6 4482.3 4482.7 2586.8 2728.6 2741.8 2744.8 2748.6 4892.8 4902.6 4907.2 4909.8 4913.8 5046.4 5285.5 5287.1 5298.3 5308.4 4866.7 4914.7 4920.3 4924.1 4928.6 5178.2 5189.0 5197.3 5208.4 5214.8 4872.1 5049.4 5087.4 5100.8 5111.4 4901.6 4907.7 4911.3 4913.0 4928.2 3635.3 3643.5 3662.8 3667.6 3669.3 4897.0 5185.3 5189.6 5194.3 5199.2 4965.7 5028.8 5057.3 5064.5 5065.7 5033.6 5044.5 5044.6 5053.8 5061.8 4865.0 4973.2 4990.8 4995.0 5018.0 4901.9 4974.3 5071.5 5090.4 5099.9 4972.4 4977.2 4983.4 4983.6 4989.6 08:42:23 INFO - PROCESS | 15109 | 08:42:23 INFO - PROCESS | 15109 | [#5] yui.html Cycles:180 Average:18218.05 Median:6327.62 stddev:28003.52 (442.6%) stddev-sans-first:28050.58 08:42:23 INFO - PROCESS | 15109 | Values: 527.1 546.1 557.2 572.7 618.7 11369.8 12352.5 12384.9 12415.1 12429.1 11856.5 12141.4 12438.8 12460.7 12581.5 747.4 769.3 771.6 771.9 773.1 616.1 737.9 762.7 766.2 770.2 814.0 814.8 816.8 817.0 817.5 806.1 806.2 806.7 807.5 807.9 475.0 482.5 486.0 488.8 564.8 11316.8 11700.2 11761.4 11774.7 11780.9 11745.5 12375.9 12410.2 12500.8 12866.7 10464.2 10680.7 10785.1 10935.8 11013.7 3776.3 3791.5 3801.4 3806.3 3948.6 65086.3 65454.7 66082.7 66905.0 70490.9 9197.7 9206.7 9450.0 9510.0 9561.7 16803.6 17073.0 17076.7 17086.7 17104.4 6326.9 6328.3 6364.9 6474.5 6694.7 3389.5 3558.6 3591.2 3648.4 3749.6 2655.6 2748.5 2755.6 2760.9 2781.7 457.7 462.3 462.9 468.6 474.7 478.2 479.4 485.2 498.8 500.5 7489.6 7581.8 7783.2 7891.6 8044.5 471.3 479.1 491.9 497.6 514.6 3595.4 3618.3 3707.9 3817.6 3820.0 103845.0 106569.0 107486.5 108102.0 111898.0 74279.0 90871.0 91139.0 92458.0 93697.5 79860.2 81392.0 81634.2 83306.6 83654.0 7318.4 7445.4 7498.3 7527.4 7545.9 48330.0 48729.0 49115.5 50223.0 50326.0 66303.3 71373.0 71835.0 72073.6 73827.0 8897.6 8971.2 8999.0 9072.6 9090.8 9590.2 9612.8 9715.7 9763.6 9941.9 9370.5 9457.0 9464.0 9468.9 9749.4 9797.5 10130.8 10138.6 10152.9 10223.3 9202.6 9544.6 9571.6 9626.3 9936.0 7469.2 7586.9 7672.8 7701.1 7755.3 7918.6 8080.8 8142.3 8143.0 8547.9 08:42:23 INFO - PROCESS | 15109 | -------- Summary: end -------- 08:42:23 INFO - PROCESS | 15109 | 08:42:24 INFO - TEST-INFO | 15109: exit 0 08:42:24 INFO - TEST-OK | dromaeo_css | took 1120439ms 08:42:24 INFO - TEST-START | kraken 08:42:24 INFO - operating with platform_type : linux_ 08:42:24 INFO - Initialising browser for kraken test... 08:42:24 INFO - TEST-INFO | started process 15416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6YZ2O3/profile http://localhost:42123/getInfo.html) 08:42:28 INFO - PROCESS | 15416 | __metrics Screen width/height:1600/1200 08:42:28 INFO - PROCESS | 15416 | colorDepth:24 08:42:28 INFO - PROCESS | 15416 | Browser inner width/height: 1024/697 08:42:28 INFO - PROCESS | 15416 | __metrics 08:42:28 INFO - PROCESS | 15416 | 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" 08:42:28 INFO - PROCESS | 15416 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:29 INFO - PROCESS | 15416 | console.error: PushService: 08:42:29 INFO - PROCESS | 15416 | stateChangeProcessEnqueue: Error transitioning state 08:42:29 INFO - PROCESS | 15416 | UnknownError 08:42:30 INFO - TEST-INFO | 15416: exit 0 08:42:30 INFO - Browser initialized. 08:42:30 INFO - Running cycle 1/1 for kraken test... 08:42:30 INFO - TEST-INFO | started process 15495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6YZ2O3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:42 INFO - PROCESS | 15495 | RSS: Main: 175558656 08:42:42 INFO - PROCESS | 15495 | 08:42:45 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42123/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:46 INFO - PROCESS | 15495 | RSS: Main: 244666368 08:42:46 INFO - PROCESS | 15495 | 08:42:48 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42123/tests/kraken/driver.html?testName=audio-dft) 08:42:49 INFO - PROCESS | 15495 | RSS: Main: 226959360 08:42:49 INFO - PROCESS | 15495 | 08:42:52 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42123/tests/kraken/driver.html?testName=audio-fft) 08:42:53 INFO - PROCESS | 15495 | RSS: Main: 301891584 08:42:53 INFO - PROCESS | 15495 | 08:42:55 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42123/tests/kraken/driver.html?testName=audio-oscillator) 08:42:56 INFO - PROCESS | 15495 | RSS: Main: 210235392 08:42:56 INFO - PROCESS | 15495 | 08:42:58 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:59 INFO - PROCESS | 15495 | RSS: Main: 214302720 08:42:59 INFO - PROCESS | 15495 | 08:43:02 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42123/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:02 INFO - PROCESS | 15495 | RSS: Main: 250511360 08:43:02 INFO - PROCESS | 15495 | 08:43:06 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42123/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:06 INFO - PROCESS | 15495 | RSS: Main: 244121600 08:43:06 INFO - PROCESS | 15495 | 08:43:09 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42123/tests/kraken/driver.html?testName=json-parse-financial) 08:43:10 INFO - PROCESS | 15495 | RSS: Main: 247672832 08:43:10 INFO - PROCESS | 15495 | 08:43:12 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:12 INFO - PROCESS | 15495 | RSS: Main: 211542016 08:43:12 INFO - PROCESS | 15495 | 08:43:14 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:15 INFO - PROCESS | 15495 | RSS: Main: 218222592 08:43:15 INFO - PROCESS | 15495 | 08:43:17 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:18 INFO - PROCESS | 15495 | RSS: Main: 224047104 08:43:18 INFO - PROCESS | 15495 | 08:43:21 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:21 INFO - PROCESS | 15495 | RSS: Main: 218484736 08:43:21 INFO - PROCESS | 15495 | 08:43:24 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:25 INFO - PROCESS | 15495 | RSS: Main: 221016064 08:43:25 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | Cycle 1(1): loaded http://localhost:42123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42123/tests/kraken/driver.html?testName=ai-astar) 08:43:27 INFO - PROCESS | 15495 | RSS: Main: 272371712 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | __start_tp_report 08:43:27 INFO - PROCESS | 15495 | _x_x_mozilla_page_load 08:43:27 INFO - PROCESS | 15495 | _x_x_mozilla_page_load_details 08:43:27 INFO - PROCESS | 15495 | |i|pagename|runs| 08:43:27 INFO - PROCESS | 15495 | |0;ai-astar;102;115;110;113;113;113;119;115;114;116 08:43:27 INFO - PROCESS | 15495 | |1;audio-beat-detection;156;121;150;181;126;146;157;125;195;134 08:43:27 INFO - PROCESS | 15495 | |2;audio-dft;162;162;162;164;161;160;161;162;163;162 08:43:27 INFO - PROCESS | 15495 | |3;audio-fft;74;75;76;164;77;75;77;117;120;77 08:43:27 INFO - PROCESS | 15495 | |4;audio-oscillator;87;88;156;87;88;88;133;87;86;133 08:43:27 INFO - PROCESS | 15495 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 08:43:27 INFO - PROCESS | 15495 | |6;imaging-darkroom;146;148;146;147;148;148;147;148;148;148 08:43:27 INFO - PROCESS | 15495 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 08:43:27 INFO - PROCESS | 15495 | |8;json-parse-financial;65;65;66;66;65;66;66;66;68;66 08:43:27 INFO - PROCESS | 15495 | |9;json-stringify-tinderbox;65;65;65;66;66;66;65;66;65;65 08:43:27 INFO - PROCESS | 15495 | |10;stanford-crypto-aes;82;82;82;83;87;82;86;85;82;82 08:43:27 INFO - PROCESS | 15495 | |11;stanford-crypto-ccm;153;139;132;143;142;133;135;132;150;143 08:43:27 INFO - PROCESS | 15495 | |12;stanford-crypto-pbkdf2;181;173;176;181;178;175;182;169;169;173 08:43:27 INFO - PROCESS | 15495 | |13;stanford-crypto-sha256-iterative;70;68;72;73;68;69;69;68;68;68 08:43:27 INFO - PROCESS | 15495 | __end_tp_report 08:43:27 INFO - PROCESS | 15495 | __start_cc_report 08:43:27 INFO - PROCESS | 15495 | _x_x_mozilla_cycle_collect,1992 08:43:27 INFO - PROCESS | 15495 | __end_cc_report 08:43:27 INFO - PROCESS | 15495 | __startTimestamp1471967007411__endTimestamp 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | ------- Summary: start ------- 08:43:27 INFO - PROCESS | 15495 | Number of tests: 14 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:4.52 (3.9%) stddev-sans-first:2.49 08:43:27 INFO - PROCESS | 15495 | Values: 102.0 115.0 110.0 113.0 113.0 113.0 119.0 115.0 114.0 116.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.00 stddev:24.44 (16.0%) stddev-sans-first:25.80 08:43:27 INFO - PROCESS | 15495 | Values: 156.0 121.0 150.0 181.0 126.0 146.0 157.0 125.0 195.0 134.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:43:27 INFO - PROCESS | 15495 | Values: 162.0 162.0 162.0 164.0 161.0 160.0 161.0 162.0 163.0 162.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:30.57 (40.5%) stddev-sans-first:31.63 08:43:27 INFO - PROCESS | 15495 | Values: 74.0 75.0 76.0 164.0 77.0 75.0 77.0 117.0 120.0 77.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:87.00 stddev:26.54 (30.5%) stddev-sans-first:27.49 08:43:27 INFO - PROCESS | 15495 | Values: 87.0 88.0 156.0 87.0 88.0 88.0 133.0 87.0 86.0 133.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:43:27 INFO - PROCESS | 15495 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.73 08:43:27 INFO - PROCESS | 15495 | Values: 146.0 148.0 146.0 147.0 148.0 148.0 147.0 148.0 148.0 148.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:43:27 INFO - PROCESS | 15495 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:43:27 INFO - PROCESS | 15495 | Values: 65.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 68.0 66.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:43:27 INFO - PROCESS | 15495 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:1.95 (2.4%) stddev-sans-first:2.01 08:43:27 INFO - PROCESS | 15495 | Values: 82.0 82.0 82.0 83.0 87.0 82.0 86.0 85.0 82.0 82.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:142.50 stddev:7.41 (5.2%) stddev-sans-first:6.24 08:43:27 INFO - PROCESS | 15495 | Values: 153.0 139.0 132.0 143.0 142.0 133.0 135.0 132.0 150.0 143.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:177.00 stddev:4.79 (2.7%) stddev-sans-first:4.68 08:43:27 INFO - PROCESS | 15495 | Values: 181.0 173.0 176.0 181.0 178.0 175.0 182.0 169.0 169.0 173.0 08:43:27 INFO - PROCESS | 15495 | 08:43:27 INFO - PROCESS | 15495 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.83 (2.7%) stddev-sans-first:1.92 08:43:27 INFO - PROCESS | 15495 | Values: 70.0 68.0 72.0 73.0 68.0 69.0 69.0 68.0 68.0 68.0 08:43:27 INFO - PROCESS | 15495 | -------- Summary: end -------- 08:43:27 INFO - PROCESS | 15495 | 08:43:28 INFO - TEST-INFO | 15495: exit 0 08:43:28 INFO - TEST-OK | kraken | took 64568ms 08:43:28 INFO - SUITE-END | took 1185s 08:43:29 INFO - Completed test suite (00:19:45) 08:43:29 INFO - javascript benchmark 08:43:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2552.9361765955855, 2594.2995391244353, 2600.1549496413663, 2603.0889188783917, 2608.061098004719, 4506.143832671798, 4522.706024108431, 4582.656300777442, 4679.0174063446675, 4688.437387513494, 4568.269076947689, 4590.839320623779, 4592.563706447882, 4596.241620132674, 4675.555822196894, 4202.432671589342, 4218.767967761772, 4341.261985462464, 4362.105768317488, 4379.64962802975, 4347.130573885235, 4377.255866502686, 4379.08039311745, 4387.583179597933, 4388.056567837914, 4166.749995000279, 4223.831046758126, 4266.1254442839145, 4309.655227581786, 4312.439382880206, 4178.101708132735, 4205.095904380542, 4210.031692710693, 4240.787960601989, 4325.653947684209, 4190.664746820247, 4211.7051806373565, 4217.514985776614, 4226.535081141072, 4232.449781528381, 4449.688521803475, 4597.60920321773, 4600.194965880991, 4608.953910460886, 4619.907601847978, 5008.499150084962, 5022.397312322508, 5040.5463508284065, 5044.117279476113, 5044.142495775727, 5023.070731914608, 5040.269160971675, 5067.138586440314, 5082.23766435034, 5085.364329458817, 4464.866054018385, 4621.768911554409, 4651.86044418668, 4661.930071048937, 4714.6464015199, 5148.768305426265, 5166.276721259027, 5166.9224961625605, 5170.819021334235, 5171.663841850268, 4965.652404331734, 4967.3294105296045, 4970.2793095001025, 4976.875578110504, 4978.0, 4818.855434336975, 4928.802847886044, 4943.851684449401, 4969.503049695001, 5052.444231134572, 4972.229304457815, 5010.774515146827, 5011.423686276052, 5014.348134742533, 5014.498550145029, 4982.053409852117, 4986.800527978913, 4998.700077995332, 5002.59979201663, 5004.874878128076, 4089.7750623715983, 4120.526139493936, 4126.360414135814, 4163.458750362433, 4237.703360764778, 3665.9633403666157, 3671.853125874935, 3691.9815400922826, 3732.738708290448, 3783.905402364963, 4398.846040388571, 4402.3836662867225, 4406.603405693503, 4410.933835992462, 4416.381706561084, 5037.874053148627, 5051.2423136529815, 5051.924221136685, 5052.090623687772, 5054.873628159326, 4220.831166753357, 4258.127083947783, 4312.288472402019, 4314.115606300701, 4381.627561657231, 4486.910261794746, 4489.6408287336935, 4492.124035812985, 4501.189785838515, 4508.797104130322, 4697.4832768395445, 4721.527847215251, 4744.667873248977, 4758.333833263277, 4763.309320148628, 4829.179039563212, 4916.631252655993, 4941.752912354296, 4956.207006878882, 5040.143175660073, 4736.73947932867, 4736.952630473651, 4748.074125545623, 4759.857204283877, 4763.857084287477, 4940.184869496637, 4942.036302920896, 4944.28307895346, 4949.901001979868, 4950.034743225036, 4774.30772537987, 4888.071266459361, 4911.263310503453, 4936.975315123402, 5019.272205530251, 4847.854564363075, 4885.5358740919555, 4886.853394398174, 4889.877753056202, 4915.21356582945, 4868.853934381974, 4888.682235654671, 4891.755412229445, 4895.583875370491, 4897.191963326154, 4647.55848194421, 4760.238361862085, 4791.6406269529225, 4806.567408933212, 4854.368932038812, 4924.803007879788, 4945.703257804544, 4971.726555039508, 4982.302477653059, 4985.177445721561, 4827.565519103297, 4833.782479788348, 4840.177169881058, 4843.346148269939, 4847.830325938575], "value": 4582.025102592543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3650710415262, 557.620817843866, 560.817734236373, 567.2823877794589, 576.2537513919474, 39300.803495982516, 40713.79643101784, 40981.385279220834, 44287.0, 44417.0, 39829.80085099571, 40429.79785101078, 40478.392824107665, 40499.0, 40501.0, 7685.961570192155, 7827.608619569027, 7834.647440865147, 7842.72550460734, 7843.254890785366, 7739.419543534257, 7823.960880195619, 7833.804154896145, 7836.333911617491, 7837.921620783776, 7888.7633370998965, 7916.40626952978, 7923.8415231695335, 7925.2867241948215, 7926.445148839583, 7828.217178282183, 7836.216378362146, 7870.803229919241, 7871.527708337518, 7873.173316801768, 7719.459637825355, 7798.649060792278, 7799.8440031199625, 7800.141984381714, 7803.063632364153, 38166.61833381659, 38444.615553844385, 38504.614953850665, 38522.0, 38526.42210366847, 2415.3478560788662, 2521.722610512842, 2563.384787650969, 2598.2724837045657, 2628.9191059683335, 28586.285342866595, 28663.426731465253, 28952.42095158085, 29109.41781164386, 29989.100326990225, 3294.58817647794, 3329.1344250494803, 3377.9662203378143, 3382.4926261061037, 3443.6212016678146, 262720.6863965687, 263714.0, 264020.0, 264164.0, 264547.0, 46431.30353044707, 46606.76696616563, 46674.76662616665, 46679.29981050287, 46684.5331546687, 48149.518504815205, 53352.0, 54877.72561137249, 55312.17031744527, 55404.0, 12965.740685186243, 13284.867151328557, 13307.0, 13345.532906348231, 13352.599422017354, 9897.406155630686, 9948.154406875497, 9965.20278377728, 10001.849972250422, 10029.147522460527, 14274.857251427353, 15488.612784680248, 16274.26765795542, 16289.592760180853, 16307.83692163087, 5915.911261331084, 6101.389861013952, 6107.816765497042, 6112.786052488142, 6171.105189747462, 786.5084322298563, 880.0363601855958, 882.580774132282, 902.1835239108617, 906.5875026862761, 27094.0, 27815.0, 28110.578341324897, 28280.575791363146, 28557.428851422854, 918.3433844800866, 985.1576901749045, 1002.1331548210891, 1028.5680014393972, 1038.6883934819523, 13918.443262269599, 14995.400183992519, 15045.623859403384, 15117.16855572932, 15283.694326113415, 372356.0, 377634.0, 378236.0, 378444.8321892615, 378611.0, 48709.512904871204, 48804.755976219894, 48825.75587122042, 48910.510894891304, 49007.0, 1123.3091648636193, 1173.3253379306932, 1175.0188592525337, 1176.8293597428326, 1178.793711100571, 26085.869570652027, 26904.73095269022, 27223.59164612493, 27594.172174834788, 27746.583801242592, 36927.07682307964, 37012.44481332836, 37046.44430333601, 37087.44368834416, 37095.62904370922, 260619.0, 262853.0, 263243.0, 263316.0, 263348.0, 30979.535306969963, 37122.628773713, 37860.62139378571, 37941.62058379381, 38006.61993380141, 30953.139487886812, 35950.0, 36345.27511423498, 45590.54409455863, 45918.0, 35384.64615353814, 35832.64167358293, 35840.10399740027, 35901.82049089738, 36366.63633363633, 35597.46603800893, 35642.821785890905, 35810.0, 35900.82049589735, 36404.635953641184, 35756.64243357533, 36605.26789464142, 37198.62801371951, 38632.80683596564, 39125.41311880267, 30230.0, 31639.367212656078, 32746.1813454656, 33060.87556428661, 33482.497762533094, 24795.610370399783, 25400.618990714785, 25814.870925645253, 25847.0, 25944.351391214615], "value": 17123.871091554167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6033363300368, 373.48086160237267, 376.58199398667483, 376.7358177354104, 385.56431232707035, 16247.0, 17115.40096096637, 17407.39074132404, 17483.475495735147, 17493.125343732794, 15297.388104475835, 15778.842211577881, 16568.66862662746, 16610.25253863576, 16700.415485458012, 4979.8008079676765, 5234.031704134747, 5237.240600112981, 5240.737963101829, 5246.029484545371, 3752.81235938202, 3989.2819292527333, 5053.444121146689, 5775.162601422791, 6041.426064523863, 6138.969305153468, 6147.538934579924, 6152.169457123298, 6154.415330543591, 6162.952298109332, 5909.881802363951, 6055.091736239578, 6076.6354018758575, 6085.878282434326, 6088.573799834014, 5079.3650793650795, 5176.663516871391, 5283.577313814885, 5289.788408463657, 5292.126799078147, 19025.80974190268, 19893.20427182911, 20936.0, 21133.04901279446, 21147.47131321714, 1941.6116776644728, 1979.9041215845193, 2099.968500472479, 2171.7502487214015, 2396.700412448444, 9230.307726920508, 9342.299327550392, 12646.241225526497, 12679.619611411581, 13012.284324362156, 1680.4790514940407, 1708.6924353616344, 1743.1632816248145, 1776.875618706691, 1779.6262784815203, 68222.8465538881, 68728.65635671839, 69500.6524967372, 69765.0, 70041.64979175072, 10126.44304563256, 10153.898461015295, 10380.844287335696, 10439.269251152346, 10623.52194151265, 13989.510367137102, 13999.44002239899, 14004.649883752783, 14007.299635018207, 14015.929920350332, 6889.448844092461, 7007.789766307019, 7145.464090193256, 7292.0, 7310.0, 6709.6367256026415, 6720.563163394364, 6842.886486648563, 6863.142107236596, 6925.065116209247, 4297.484301883794, 4378.605925466723, 4392.38506609075, 4501.549845015472, 4537.977310113428, 1574.826769055403, 1632.991835040841, 1689.1300979995312, 1806.2684612731864, 1885.1139964216795, 761.919998400171, 802.1216767639426, 825.8513467575774, 850.6980022092068, 868.4485351801525, 15510.146941918078, 15590.610234744223, 16752.329906803592, 16838.158092095346, 17551.29794808219, 795.2365728900205, 808.6644042722204, 823.5593957232852, 858.6737039924789, 884.960176792033, 9114.270858331318, 9747.0, 9790.118889299998, 9799.167070799062, 9858.359206651545, 414403.0, 417595.0, 418067.0, 443555.0, 446746.0, 48180.0, 48841.0, 49521.75239123854, 77944.61027694939, 79528.602356989, 871.9441721650857, 874.6894852327332, 897.0804924951846, 906.7370462565914, 907.9228265597499, 15773.29020194117, 16304.347826086823, 16580.025992202533, 16783.832161678227, 17100.486985390457, 28365.71634283631, 36339.90980270596, 37357.25285494329, 37984.43023354707, 38118.0, 51359.0, 51620.48379516157, 52392.0, 54093.0, 54565.0, 7692.34615057704, 7846.725364612211, 7850.411219158472, 8013.959930200312, 8091.797705057421, 9927.602895884083, 9988.300818942604, 11812.70468238301, 12003.279803211835, 12642.0, 6516.413522782972, 6973.267806880407, 9810.018998100133, 9840.11438970496, 10155.0, 6806.591604503746, 10109.898901011189, 10178.694639160836, 10260.486975651038, 10293.485325733833, 10002.649907253211, 10080.344777589433, 10087.546060427445, 10115.7471063224, 10272.178225742073, 7481.962590187014, 7675.961620191863, 7682.807929801576, 7814.296713295831, 7847.646855891385, 9654.855177172207, 9998.25013124004, 10055.296129271173, 10143.49282535885, 10285.588576456857], "value": 8185.540312689379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.5997109466498, 1376.7108907129502, 1425.914445133292, 1643.654832485178, 1671.1644177911044, 6704.932950670492, 7018.087648605674, 7426.851462970737, 8083.555404452753, 8090.190980901907, 7258.963705181467, 7494.812629684247, 7541.509801862875, 7702.922970770291, 7744.496607720508, 2122.639151344275, 2145.2277180215187, 2145.871247725134, 2147.7852214778554, 2161.3083813179787, 1819.7725284339458, 2109.862858914166, 2112.535242246703, 2139.368886178581, 2204.096320508592, 2110.9788902110936, 2126.1601667341392, 2131.0, 2145.1526646974435, 2145.356393082077, 2077.45986043629, 2082.4481512399225, 2114.450242936832, 2118.8834614096218, 2123.2568600989684, 2040.3271714054488, 2059.577786553753, 2062.7215325930956, 2067.286786058822, 2100.411884672294, 7987.840243195162, 8058.476199047043, 8060.395470339748, 8071.112177660452, 8092.757217283432, 4280.700350975433, 4399.868003959887, 4401.097774956126, 4420.46954365475, 4424.269995450747, 2741.300968253103, 2876.741093301592, 2899.6230490036373, 2904.2739315171207, 2920.4305160493714, 878.4553576782436, 885.2254277507182, 891.8305521950808, 898.2813749000774, 900.9234215091725, 10849.67450976472, 10876.673699789018, 10877.12982961369, 10878.456077196188, 10908.34549927007, 3963.7621742694955, 4012.4783778109245, 4145.585441455831, 4165.125323682, 4204.285271503852, 8459.873101903477, 8615.655373784979, 8625.654973800978, 8632.438891472035, 8636.784080397914, 4421.756803375781, 4432.601065904084, 4435.645148388121, 4436.26801577736, 4443.622292105208, 3990.2019596080318, 4116.320807066801, 4144.772037537904, 4147.979260103741, 4150.896227594334, 3233.337165880989, 3304.3391321735267, 3330.0342900559053, 3348.7655864089766, 3384.543086683266, 929.9816700712709, 957.9425234485954, 958.166395236149, 967.7435479597913, 981.5239608789731, 685.6434653979902, 711.210556282526, 733.5012191709689, 736.5911918885071, 752.6876346316218, 5077.39071311445, 5384.5692344612335, 5393.649412788156, 5474.644148130438, 5578.63738856973, 835.4527784301292, 859.4499520307008, 860.7347199616554, 863.8747381629754, 909.5634095634133, 3473.6873681368797, 3581.8746343877838, 3586.1751797086818, 3667.331364229323, 3745.0, 9414.858777118348, 9831.459269740233, 9889.109980101824, 9892.109710126124, 9923.751906202402, 9631.0, 9820.607175713034, 9848.06443387877, 9851.261155413373, 9880.209583233323, 7310.268973102754, 7445.664945077485, 7453.590052547053, 7454.030975973197, 7464.925350746423, 5168.715720635401, 5226.503482169188, 5278.683279003272, 5286.20706893969, 5389.7035663038905, 8848.955755221183, 8922.776930576787, 8932.553372331227, 9042.502662353634, 9086.0, 9163.587638556148, 9209.585568649292, 9243.142608911505, 9294.442333460014, 9320.114589114024, 6026.0659597762415, 6189.9690501549, 6191.690415479118, 6191.81424557264, 6196.318404975359, 7308.671109799965, 7322.0847394075745, 7390.408767298711, 7390.815229619303, 7409.481336306407, 5598.916016259678, 5784.450477204827, 6583.242927063257, 6680.365365290289, 6684.398404143456, 6530.510211734234, 6604.273529911802, 6663.533552651268, 6665.866682666417, 6679.265280819203, 6246.187995560548, 6332.651704156316, 6355.428011478804, 6364.840878978062, 6366.586171898812, 4450.310201918708, 4667.066586682609, 4689.366935463669, 4733.881652958566, 4748.928766068442, 4434.0, 4559.726416415026, 4677.485476597503, 4744.644151688568, 4782.067496838084], "value": 4041.299352087267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.09670987038885, 308.2540252588735, 311.10402042118704, 313.61268832991266, 314.9811011339321, 4687.414073240845, 4748.786304616292, 4750.881227969294, 4771.35586695796, 4783.210770222913, 4716.90566188676, 4719.126961512123, 4721.575058244757, 4725.527447255281, 4732.858014259569, 3593.730470214731, 3655.6161603031696, 3686.152184997452, 3732.3654978653694, 3781.678557322617, 3760.236226373613, 3768.586779957516, 3775.4903088083033, 3780.9621903780885, 3790.3556395412847, 3733.551973763152, 3736.831842567091, 3740.906477338061, 3747.6627103560672, 3753.493278407421, 3536.9115772105647, 3603.405438102723, 3732.925341493155, 3744.2324323513612, 3748.4939533162947, 3337.2324365396094, 3349.2631621043333, 3350.8219657223, 3356.56364672591, 3358.6473420290763, 4621.260598304255, 4642.466116396624, 4644.419447569054, 4646.512116227781, 4653.0228651983125, 4174.624283814441, 4247.87256382309, 4272.87181384559, 4277.935830962538, 4301.505326887417, 4927.285543596195, 4946.851594452172, 4957.950420495785, 4962.15643340633, 4969.0, 3659.8170091495317, 3663.3955397359405, 3669.321175582526, 3670.082479380155, 3675.7059435245114, 4891.951080489221, 5197.818076367347, 5202.947970520322, 5207.203514787392, 5211.609129315317, 3576.123849656851, 3635.563732352082, 3636.6726994570618, 3639.5996440391536, 3649.6532829381167, 3683.5211422514903, 3684.6868016218923, 3685.244524872395, 3692.7415080944074, 3693.7045036397026, 4194.832206711759, 4202.936955945664, 4208.116295577963, 4210.179015092028, 4213.52526615682, 4691.0, 4983.152864013126, 4985.252212168131, 4995.150824359867, 5006.774695138727, 1284.9871501285054, 1292.8125421813784, 1295.3652710171948, 1296.371259938929, 1297.3902265934996, 808.4987307869159, 822.7531740477833, 829.5313148071441, 845.6236974546391, 846.5090247656344, 4331.263685173528, 4468.776561171993, 4473.561908759733, 4474.955250447519, 4480.372747815309, 5111.97444012785, 5129.9230511542355, 5131.79472821083, 5134.486551344836, 5141.177411614199, 4474.485434175046, 4474.7762611869275, 4479.552044795494, 4482.260427029503, 4482.686211965196, 2586.8059895507913, 2728.577070554067, 2741.766205207625, 2744.7804175665897, 2748.6151938728594, 4892.828750993698, 4902.583280421204, 4907.1903135982875, 4909.828156014522, 4913.754312284372, 5046.44489106198, 5285.497877701612, 5287.127623942083, 5298.258243845865, 5308.389535203501, 4866.7079975200895, 4914.655974081851, 4920.261960705851, 4924.138275801721, 4928.6057115431395, 5178.223266510054, 5188.9622075585785, 5197.272381866466, 5208.401033881152, 5214.843554693365, 4872.147374209429, 5049.394072711299, 5087.414947280962, 5100.795968161232, 5111.386633603991, 4901.632377571767, 4907.68100073494, 4911.3369695090705, 4912.95087049125, 4928.211486162197, 3635.2729454108753, 3643.544556930384, 3662.7619204751604, 3667.5782285036494, 3669.321175582526, 4896.975515122402, 5185.27406163145, 5189.636725429184, 5194.3247377840635, 5199.220116982483, 4965.677230979974, 5028.773705183348, 5057.280524621499, 5064.4935506449065, 5065.721385323843, 5033.634191929787, 5044.520770526794, 5044.596432285482, 5053.84838454847, 5061.822836200715, 4864.951350486592, 4973.179425394914, 4990.750462476789, 4994.951060277383, 5017.974910125572, 4901.926471103007, 4974.328465657235, 5071.467495912876, 5090.371081253963, 5099.949000509948, 4972.353594032753, 4977.178765503651, 4983.352164218773, 4983.551480366785, 4989.625778066587], "value": 3786.85673695835, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.0670912484904, 546.1071148671921, 557.2171099605054, 572.661344865548, 618.7092066728636, 11369.829452558208, 12352.50589976401, 12384.876151238484, 12415.130940834133, 12429.067819913498, 11856.525738970453, 12141.392930353491, 12438.751224975495, 12460.688482787935, 12581.496740130407, 747.4468893019167, 769.3191525499944, 771.5602106799126, 771.8687823070092, 773.0838955837322, 616.0574321288414, 737.8524295140967, 762.7368557847561, 766.1916677904808, 770.218228498075, 814.0313027497289, 814.7800093974623, 816.808050108224, 816.967321307147, 817.5094943034162, 806.1293802693077, 806.2340776262574, 806.6571707024491, 807.5074204735107, 807.9394045446586, 474.96912700674693, 482.5150723522837, 486.0352200881248, 488.8069212660979, 564.802319188285, 11316.773664526745, 11700.239484433485, 11761.353125578089, 11774.705632359259, 11780.941095294555, 11745.4714537846, 12375.876241237562, 12410.193337433127, 12500.8124878126, 12866.742665146645, 10464.162866970624, 10680.679579612624, 10785.083267922237, 10935.83596246057, 11013.724656883562, 3776.3013842439236, 3791.5071040764524, 3801.3917773156163, 3806.2768074066116, 3948.6446219840354, 65086.3491365085, 65454.67272663654, 66082.66958665175, 66905.0, 70490.94263586102, 9197.712320275166, 9206.677766278148, 9450.0, 9509.952450237704, 9561.713148605553, 16803.579910502336, 17073.0, 17076.743848842278, 17086.743698844526, 17104.401345952832, 6326.936730632635, 6328.303886572473, 6364.872702546016, 6474.514411419163, 6694.732210711614, 3389.457686770105, 3558.5551806024246, 3591.245838373971, 3648.427838507649, 3749.5500539934837, 2655.6282120503147, 2748.477789220082, 2755.641766570373, 2760.875760590778, 2781.735735105162, 457.7185031205784, 462.2834606360128, 462.90973260213934, 468.5806203447895, 474.71042663974947, 478.18230825289146, 479.41990191867535, 485.23090900921727, 498.75810232037435, 500.5095006893192, 7489.625518724151, 7581.848363032708, 7783.182765809622, 7891.638975398274, 8044.477108988014, 471.25541644202076, 479.09451137350436, 491.91391506486224, 497.60689055646355, 514.5626217714912, 3595.3528364894046, 3618.3306088373733, 3707.870224542128, 3817.5800661927165, 3819.961800382016, 103845.0, 106569.0, 107486.46256768666, 108102.0, 111898.0, 74279.0, 90871.0, 91139.0, 92458.0, 93697.53151234337, 79860.20139798528, 81391.99999999882, 81634.18365816266, 83306.58346708228, 83654.0, 7318.377937875341, 7445.4043676506835, 7498.287662672037, 7527.435442341737, 7545.886811697938, 48330.0, 48729.0, 49115.508844912525, 50223.0, 50326.0, 66303.33696662972, 71373.0, 71835.0, 72073.6396318015, 73827.0, 8897.599608017525, 8971.192592666692, 8998.955005224932, 9072.637094516145, 9090.818183636422, 9590.184834289164, 9612.807743845224, 9715.70852874415, 9763.56063977137, 9941.900580994386, 9370.484623345781, 9457.0, 9464.0, 9468.905310946802, 9749.415035097916, 9797.461139637388, 10130.8480372793, 10138.594456221963, 10152.949235253776, 10223.335483193569, 9202.585883635387, 9544.618215271588, 9571.61713531451, 9626.32615716893, 9936.006399360296, 7469.178390377163, 7586.886196706943, 7672.769816905502, 7701.1143718473095, 7755.3407960324, 7918.604069796372, 8080.757577272691, 8142.307903828241, 8142.959285203536, 8547.91452085496], "value": 6118.766453094087, "unit": "score"}], "name": "dromaeo_css", "value": 6259.458431056096, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 110.0, 113.0, 113.0, 113.0, 119.0, 115.0, 114.0, 116.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 150.0, 181.0, 126.0, 146.0, 157.0, 125.0, 195.0, 134.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 164.0, 77.0, 75.0, 77.0, 117.0, 120.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 156.0, 87.0, 88.0, 88.0, 133.0, 87.0, 86.0, 133.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 83.0, 87.0, 82.0, 86.0, 85.0, 82.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 139.0, 132.0, 143.0, 142.0, 133.0, 135.0, 132.0, 150.0, 143.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 173.0, 176.0, 181.0, 178.0, 175.0, 182.0, 169.0, 169.0, 173.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 72.0, 73.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1579.4, "alertThreshold": 2.0}]} 08:43:29 INFO - Return code: 0 08:43:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:29 INFO - # TBPL SUCCESS # 08:43:29 INFO - Running post-action listener: _resource_record_post_action 08:43:29 INFO - [mozharness: 2016-08-23 15:43:29.210942Z] Finished run-tests step (success) 08:43:29 INFO - Running post-run listener: _resource_record_post_run 08:43:29 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 414023680; Read time: 0; Write time: 323044 08:43:29 INFO - TinderboxPrint: CPU usage
13.2% 08:43:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:43:29 INFO - TinderboxPrint: I/O write bytes / time
414,023,680 / 323,044 08:43:29 INFO - TinderboxPrint: CPU idle
8,320.5 (86.8%) 08:43:29 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 08:43:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120934400; Read time: 0; Write time: 114128 08:43:29 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292552704; Read time: 0; Write time: 208584 08:43:29 INFO - Running post-run listener: _upload_blobber_files 08:43:29 INFO - Blob upload gear active. 08:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:29 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 08:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:31 INFO - (blobuploader) - INFO - Done attempting. 08:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:31 INFO - (blobuploader) - INFO - Done attempting. 08:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:40 INFO - (blobuploader) - INFO - Done attempting. 08:43:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:40 INFO - Return code: 0 08:43:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b5f129effcd4f6bb9703f8cdc9b9620e71cf7d56484f096fbaab82d0a0198d77b3c67b9e43b1725cfcb87b8a57c684337cad3014888355d6127cc65b9a123fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e45527e3e370bb76a04e100158f81854325d9a2073693c77156d848b0e9c27d79c4ae541d0a8671de6df0bbe173071c2ab5f7a538dca4afff603626d0ad73e59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad9dab7841fd24f97dac531f3c40f5354e378ce859d4d11b7117899df514cf1a4c0bfe38265baa192bce4b8db9d3808d8853ed23b9b74855fb6083f1c42f00f"} 08:43:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:40 INFO - Contents: 08:43:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b5f129effcd4f6bb9703f8cdc9b9620e71cf7d56484f096fbaab82d0a0198d77b3c67b9e43b1725cfcb87b8a57c684337cad3014888355d6127cc65b9a123fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e45527e3e370bb76a04e100158f81854325d9a2073693c77156d848b0e9c27d79c4ae541d0a8671de6df0bbe173071c2ab5f7a538dca4afff603626d0ad73e59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad9dab7841fd24f97dac531f3c40f5354e378ce859d4d11b7117899df514cf1a4c0bfe38265baa192bce4b8db9d3808d8853ed23b9b74855fb6083f1c42f00f"} 08:43:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:40 INFO - Copying logs to upload dir... 08:43:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.733373 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-23 08:43:40.456121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:43:40.459668) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b5f129effcd4f6bb9703f8cdc9b9620e71cf7d56484f096fbaab82d0a0198d77b3c67b9e43b1725cfcb87b8a57c684337cad3014888355d6127cc65b9a123fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e45527e3e370bb76a04e100158f81854325d9a2073693c77156d848b0e9c27d79c4ae541d0a8671de6df0bbe173071c2ab5f7a538dca4afff603626d0ad73e59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad9dab7841fd24f97dac531f3c40f5354e378ce859d4d11b7117899df514cf1a4c0bfe38265baa192bce4b8db9d3808d8853ed23b9b74855fb6083f1c42f00f"} build_url:https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/MbmVBh_pTk255ckHWE_Cjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b5f129effcd4f6bb9703f8cdc9b9620e71cf7d56484f096fbaab82d0a0198d77b3c67b9e43b1725cfcb87b8a57c684337cad3014888355d6127cc65b9a123fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e45527e3e370bb76a04e100158f81854325d9a2073693c77156d848b0e9c27d79c4ae541d0a8671de6df0bbe173071c2ab5f7a538dca4afff603626d0ad73e59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad9dab7841fd24f97dac531f3c40f5354e378ce859d4d11b7117899df514cf1a4c0bfe38265baa192bce4b8db9d3808d8853ed23b9b74855fb6083f1c42f00f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:43:40.489070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:43:40.489429) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471965768.874097-1211457191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004366 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:43:40.572429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:43:40.572800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:43:40.573173) ========= ========= Total master_lag: 0.18 =========