builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1468046162.25 results: success (0) buildid: 20160708221526 builduid: 6a8fb5deeb85483c876ee3f4d3396c6e revision: e3dcf062007e280ccf06e7bed7ff904d0fb44418 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.251487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.251950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.252225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.267802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.268166) ========= 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=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 23:36:02-- 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% 46.0M=0s 2016-07-08 23:36:02 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138247 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.630013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.635699) ========= 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=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015937 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:02.687622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 23:36:02.687924) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e3dcf062007e280ccf06e7bed7ff904d0fb44418 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e3dcf062007e280ccf06e7bed7ff904d0fb44418 --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=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 23:36:02,858 truncating revision to first 12 chars 2016-07-08 23:36:02,858 Setting DEBUG logging. 2016-07-08 23:36:02,858 attempt 1/10 2016-07-08 23:36:02,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e3dcf062007e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 23:36:03,709 unpacking tar archive at: autoland-e3dcf062007e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197965 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 23:36:03.912001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:03.912343) ========= script_repo_revision: e3dcf062007e280ccf06e7bed7ff904d0fb44418 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:03.912743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:03.913035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:36:03.921954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-08 23:36:03.922326) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:36:04 INFO - MultiFileLogger online at 20160708 23:36:04 in /builds/slave/test 23:36:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 23:36:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:36:04 INFO - {'append_to_log': False, 23:36:04 INFO - 'base_work_dir': '/builds/slave/test', 23:36:04 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:36:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:36:04 INFO - 'branch': 'Autoland-Non-PGO', 23:36:04 INFO - 'buildbot_json_path': 'buildprops.json', 23:36:04 INFO - 'config_files': ('talos/linux_config.py',), 23:36:04 INFO - 'default_actions': ('clobber', 23:36:04 INFO - 'read-buildbot-config', 23:36:04 INFO - 'download-and-extract', 23:36:04 INFO - 'populate-webroot', 23:36:04 INFO - 'create-virtualenv', 23:36:04 INFO - 'install', 23:36:04 INFO - 'run-tests'), 23:36:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:36:04 INFO - 'download_minidump_stackwalk': True, 23:36:04 INFO - 'download_symbols': 'ondemand', 23:36:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:36:04 INFO - 'tooltool.py': '/tools/tooltool.py', 23:36:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:36:04 INFO - '/tools/misc-python/virtualenv.py')}, 23:36:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:36:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:36:04 INFO - 'installer_path': 'installer.exe', 23:36:04 INFO - 'log_level': 'info', 23:36:04 INFO - 'log_name': 'talos', 23:36:04 INFO - 'log_to_console': True, 23:36:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:36:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:36:04 INFO - 'opt_config_files': (), 23:36:04 INFO - 'pip_index': False, 23:36:04 INFO - 'sps_profile': False, 23:36:04 INFO - 'sps_profile_interval': 0, 23:36:04 INFO - 'suite': 'dromaeojs', 23:36:04 INFO - 'system_bits': '32', 23:36:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:36:04 INFO - 'title': 'talos-linux64-ix-038', 23:36:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:36:04 INFO - 'use_talos_json': True, 23:36:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:36:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:36:04 INFO - 'work_dir': 'build'} 23:36:04 INFO - ##### 23:36:04 INFO - ##### Running clobber step. 23:36:04 INFO - ##### 23:36:04 INFO - Running pre-action listener: _resource_record_pre_action 23:36:04 INFO - Running main action method: clobber 23:36:04 INFO - rmtree: /builds/slave/test/build 23:36:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:05 INFO - Running post-action listener: _resource_record_post_action 23:36:05 INFO - ##### 23:36:05 INFO - ##### Finished clobber step (success) 23:36:05 INFO - ##### 23:36:05 INFO - ##### 23:36:05 INFO - ##### Running read-buildbot-config step. 23:36:05 INFO - ##### 23:36:05 INFO - Running pre-action listener: _resource_record_pre_action 23:36:05 INFO - Running main action method: read_buildbot_config 23:36:05 INFO - Using buildbot properties: 23:36:05 INFO - { 23:36:05 INFO - "project": "", 23:36:05 INFO - "product": "firefox", 23:36:05 INFO - "script_repo_revision": "production", 23:36:05 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 23:36:05 INFO - "repository": "", 23:36:05 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 23:36:05 INFO - "buildid": "20160708221526", 23:36:05 INFO - "pgo_build": "False", 23:36:05 INFO - "basedir": "/builds/slave/test", 23:36:05 INFO - "buildnumber": 101, 23:36:05 INFO - "slavename": "talos-linux64-ix-038", 23:36:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:36:05 INFO - "platform": "ubuntu64_hw", 23:36:05 INFO - "scheduler": "tests-autoland-linux64-talos", 23:36:05 INFO - "branch": "autoland", 23:36:05 INFO - "repo_path": "integration/autoland", 23:36:05 INFO - "revision": "e3dcf062007e280ccf06e7bed7ff904d0fb44418", 23:36:05 INFO - "stage_platform": "linux64", 23:36:05 INFO - "builduid": "6a8fb5deeb85483c876ee3f4d3396c6e", 23:36:05 INFO - "slavebuilddir": "test" 23:36:05 INFO - } 23:36:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:36:05 INFO - Running post-action listener: _resource_record_post_action 23:36:05 INFO - ##### 23:36:05 INFO - ##### Finished read-buildbot-config step (success) 23:36:05 INFO - ##### 23:36:05 INFO - ##### 23:36:05 INFO - ##### Running download-and-extract step. 23:36:05 INFO - ##### 23:36:05 INFO - Running pre-action listener: _resource_record_pre_action 23:36:05 INFO - Running main action method: download_and_extract 23:36:05 INFO - mkdir: /builds/slave/test/build/tests 23:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:05 INFO - https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:36:11 INFO - Downloaded 1361 bytes. 23:36:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:11 INFO - Using the following test package requirements: 23:36:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:36:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:36:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'jsshell-linux-x86_64.zip'], 23:36:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:36:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:36:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:36:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:36:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:36:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:11 INFO - https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:36:16 INFO - Downloaded 22733366 bytes. 23:36:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:36:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:36:17 INFO - Return code: 0 23:36:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:17 INFO - https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:36:18 INFO - Downloaded 22733366 bytes. 23:36:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:36:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:36:20 INFO - Return code: 0 23:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:20 INFO - https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:36:21 INFO - Downloaded 14403333 bytes. 23:36:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:36:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:36:21 INFO - Return code: 0 23:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:21 INFO - https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:36:23 INFO - Downloaded 56651294 bytes. 23:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:23 INFO - mkdir: /builds/slave/test/properties 23:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 23:36:23 INFO - Contents: 23:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:24 INFO - Running post-action listener: _resource_record_post_action 23:36:24 INFO - Running post-action listener: set_extra_try_arguments 23:36:24 INFO - ##### 23:36:24 INFO - ##### Finished download-and-extract step (success) 23:36:24 INFO - ##### 23:36:24 INFO - ##### 23:36:24 INFO - ##### Running populate-webroot step. 23:36:24 INFO - ##### 23:36:24 INFO - Running pre-action listener: _resource_record_pre_action 23:36:24 INFO - Running main action method: populate_webroot 23:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:36:24 INFO - '--tppagecycles', 23:36:24 INFO - '7'], 23:36:24 INFO - 'tests': ['tsvgm']}}, 23:36:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:36:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:36:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:36:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['damp', 'tps']}, 23:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'tests': ['damp', 'tps']}, 23:36:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['dromaeo_dom']}, 23:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:36:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['basic_compositor_video']}, 23:36:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:36:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'other-e10s': {'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['a11yr', 23:36:24 INFO - 'ts_paint', 23:36:24 INFO - 'tpaint', 23:36:24 INFO - 'sessionrestore', 23:36:24 INFO - 'sessionrestore_no_auto_restore', 23:36:24 INFO - 'tabpaint']}, 23:36:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['tsvgx', 23:36:24 INFO - 'tsvgr_opacity', 23:36:24 INFO - 'tart', 23:36:24 INFO - 'tscrollx', 23:36:24 INFO - 'cart']}, 23:36:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:36:24 INFO - 'tsvgr_opacity', 23:36:24 INFO - 'tart', 23:36:24 INFO - 'tscrollx', 23:36:24 INFO - 'cart']}, 23:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'talos_options': ['--disable-e10s'], 23:36:24 INFO - 'tests': ['tp5o']}, 23:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'tests': ['tp5o']}, 23:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'talos_options': ['--disable-e10s', 23:36:24 INFO - '--xperf_path', 23:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:24 INFO - 'tests': ['tp5n']}, 23:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:24 INFO - 'talos_options': ['--xperf_path', 23:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:24 INFO - 'tests': ['tp5n']}}, 23:36:24 INFO - 'talos.zip': {'path': '', 23:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:36:24 INFO - Running post-action listener: _resource_record_post_action 23:36:24 INFO - ##### 23:36:24 INFO - ##### Finished populate-webroot step (success) 23:36:24 INFO - ##### 23:36:24 INFO - ##### 23:36:24 INFO - ##### Running create-virtualenv step. 23:36:24 INFO - ##### 23:36:24 INFO - Running pre-action listener: _resource_record_pre_action 23:36:24 INFO - Running main action method: create_virtualenv 23:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 23:36:24 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 23:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:36:24 INFO - Using real prefix '/usr' 23:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 23:36:26 INFO - Installing pip.................done. 23:36:26 INFO - Return code: 0 23:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36: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', 'pip>=1.5'] in /builds/slave/test/build 23:36: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 pip>=1.5 23:36:26 INFO - Using env: {'DISPLAY': ':0', 23:36:26 INFO - 'HOME': '/home/cltbld', 23:36:26 INFO - 'LANG': 'en_US.UTF-8', 23:36:26 INFO - 'LANGUAGE': 'en_US:en', 23:36:26 INFO - 'LOGNAME': 'cltbld', 23:36:26 INFO - 'MAIL': '/var/mail/cltbld', 23:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:26 INFO - 'MOZ_NO_REMOTE': '1', 23:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:26 INFO - 'NO_EM_RESTART': '1', 23:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:26 INFO - 'PWD': '/builds/slave/test', 23:36:26 INFO - 'SHELL': '/bin/bash', 23:36:26 INFO - 'SHLVL': '1', 23:36:26 INFO - 'TERM': 'linux', 23:36:26 INFO - 'TMOUT': '86400', 23:36:26 INFO - 'USER': 'cltbld', 23:36:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:26 INFO - '_': '/tools/buildbot/bin/python'} 23:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:26 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 23:36:26 INFO - Cleaning up... 23:36:26 INFO - Return code: 0 23:36:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', '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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:36: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 psutil>=3.1.1 23:36:26 INFO - Using env: {'DISPLAY': ':0', 23:36:26 INFO - 'HOME': '/home/cltbld', 23:36:26 INFO - 'LANG': 'en_US.UTF-8', 23:36:26 INFO - 'LANGUAGE': 'en_US:en', 23:36:26 INFO - 'LOGNAME': 'cltbld', 23:36:26 INFO - 'MAIL': '/var/mail/cltbld', 23:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:26 INFO - 'MOZ_NO_REMOTE': '1', 23:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:26 INFO - 'NO_EM_RESTART': '1', 23:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:26 INFO - 'PWD': '/builds/slave/test', 23:36:26 INFO - 'SHELL': '/bin/bash', 23:36:26 INFO - 'SHLVL': '1', 23:36:26 INFO - 'TERM': 'linux', 23:36:26 INFO - 'TMOUT': '86400', 23:36:26 INFO - 'USER': 'cltbld', 23:36:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:26 INFO - '_': '/tools/buildbot/bin/python'} 23:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:27 INFO - Downloading/unpacking psutil>=3.1.1 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:29 INFO - Installing collected packages: psutil 23:36:29 INFO - Running setup.py install for psutil 23:36:29 INFO - building 'psutil._psutil_linux' extension 23:36:29 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 23:36:29 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 23:36:29 INFO - building 'psutil._psutil_posix' extension 23:36:29 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 23:36:29 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 23:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:29 INFO - Successfully installed psutil 23:36:29 INFO - Cleaning up... 23:36:29 INFO - Return code: 0 23:36:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:36:29 INFO - Using env: {'DISPLAY': ':0', 23:36:29 INFO - 'HOME': '/home/cltbld', 23:36:29 INFO - 'LANG': 'en_US.UTF-8', 23:36:29 INFO - 'LANGUAGE': 'en_US:en', 23:36:29 INFO - 'LOGNAME': 'cltbld', 23:36:29 INFO - 'MAIL': '/var/mail/cltbld', 23:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:29 INFO - 'MOZ_NO_REMOTE': '1', 23:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:29 INFO - 'NO_EM_RESTART': '1', 23:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:29 INFO - 'PWD': '/builds/slave/test', 23:36:29 INFO - 'SHELL': '/bin/bash', 23:36:29 INFO - 'SHLVL': '1', 23:36:29 INFO - 'TERM': 'linux', 23:36:29 INFO - 'TMOUT': '86400', 23:36:29 INFO - 'USER': 'cltbld', 23:36:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:29 INFO - '_': '/tools/buildbot/bin/python'} 23:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:36:31 INFO - Installing collected packages: mozsystemmonitor 23:36:31 INFO - Running setup.py install for mozsystemmonitor 23:36:31 INFO - Successfully installed mozsystemmonitor 23:36:31 INFO - Cleaning up... 23:36:31 INFO - Return code: 0 23:36:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:36:31 INFO - Using env: {'DISPLAY': ':0', 23:36:31 INFO - 'HOME': '/home/cltbld', 23:36:31 INFO - 'LANG': 'en_US.UTF-8', 23:36:31 INFO - 'LANGUAGE': 'en_US:en', 23:36:31 INFO - 'LOGNAME': 'cltbld', 23:36:31 INFO - 'MAIL': '/var/mail/cltbld', 23:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:31 INFO - 'MOZ_NO_REMOTE': '1', 23:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:31 INFO - 'NO_EM_RESTART': '1', 23:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:31 INFO - 'PWD': '/builds/slave/test', 23:36:31 INFO - 'SHELL': '/bin/bash', 23:36:31 INFO - 'SHLVL': '1', 23:36:31 INFO - 'TERM': 'linux', 23:36:31 INFO - 'TMOUT': '86400', 23:36:31 INFO - 'USER': 'cltbld', 23:36:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:31 INFO - '_': '/tools/buildbot/bin/python'} 23:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:32 INFO - Downloading/unpacking jsonschema==2.5.1 23:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:36:33 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 23:36:33 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 23:36:33 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 23:36:33 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 23:36:33 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 23:36:33 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 23:36:34 INFO - Downloading functools32-3.2.3-2.tar.gz 23:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:36:34 INFO - warning: no files found matching '*.txt' 23:36:34 INFO - no previously-included directories found matching 'build' 23:36:34 INFO - no previously-included directories found matching 'dist' 23:36:34 INFO - no previously-included directories found matching '.git*' 23:36:34 INFO - Installing collected packages: jsonschema, functools32 23:36:34 INFO - Running setup.py install for functools32 23:36:34 INFO - warning: no files found matching '*.txt' 23:36:34 INFO - no previously-included directories found matching 'build' 23:36:34 INFO - no previously-included directories found matching 'dist' 23:36:34 INFO - no previously-included directories found matching '.git*' 23:36:34 INFO - Successfully installed jsonschema functools32 23:36:34 INFO - Cleaning up... 23:36:34 INFO - Return code: 0 23:36:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:36:34 INFO - Using env: {'DISPLAY': ':0', 23:36:34 INFO - 'HOME': '/home/cltbld', 23:36:34 INFO - 'LANG': 'en_US.UTF-8', 23:36:34 INFO - 'LANGUAGE': 'en_US:en', 23:36:34 INFO - 'LOGNAME': 'cltbld', 23:36:34 INFO - 'MAIL': '/var/mail/cltbld', 23:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:34 INFO - 'MOZ_NO_REMOTE': '1', 23:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:34 INFO - 'NO_EM_RESTART': '1', 23:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:34 INFO - 'PWD': '/builds/slave/test', 23:36:34 INFO - 'SHELL': '/bin/bash', 23:36:34 INFO - 'SHLVL': '1', 23:36:34 INFO - 'TERM': 'linux', 23:36:34 INFO - 'TMOUT': '86400', 23:36:34 INFO - 'USER': 'cltbld', 23:36:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:34 INFO - '_': '/tools/buildbot/bin/python'} 23:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:34 INFO - Downloading/unpacking blobuploader==1.2.4 23:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:36 INFO - Downloading blobuploader-1.2.4.tar.gz 23:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:36:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:36:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:37 INFO - Downloading docopt-0.6.1.tar.gz 23:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 23:36:37 INFO - Running setup.py install for blobuploader 23:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:36:37 INFO - Running setup.py install for requests 23:36:37 INFO - Running setup.py install for docopt 23:36:37 INFO - Successfully installed blobuploader requests docopt 23:36:37 INFO - Cleaning up... 23:36:37 INFO - Return code: 0 23:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:37 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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:37 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 23:36:37 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 23:36:37 INFO - Using env: {'DISPLAY': ':0', 23:36:37 INFO - 'HOME': '/home/cltbld', 23:36:37 INFO - 'LANG': 'en_US.UTF-8', 23:36:37 INFO - 'LANGUAGE': 'en_US:en', 23:36:37 INFO - 'LOGNAME': 'cltbld', 23:36:37 INFO - 'MAIL': '/var/mail/cltbld', 23:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:37 INFO - 'MOZ_NO_REMOTE': '1', 23:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:37 INFO - 'NO_EM_RESTART': '1', 23:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:37 INFO - 'PWD': '/builds/slave/test', 23:36:37 INFO - 'SHELL': '/bin/bash', 23:36:37 INFO - 'SHLVL': '1', 23:36:37 INFO - 'TERM': 'linux', 23:36:37 INFO - 'TMOUT': '86400', 23:36:37 INFO - 'USER': 'cltbld', 23:36:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:37 INFO - '_': '/tools/buildbot/bin/python'} 23:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:38 INFO - Running setup.py (path:/tmp/pip-_OgFkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:38 INFO - Running setup.py (path:/tmp/pip-cRGw6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:38 INFO - Running setup.py (path:/tmp/pip-0oEw5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:38 INFO - Running setup.py (path:/tmp/pip-lZHPzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:38 INFO - Running setup.py (path:/tmp/pip-svRfSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:38 INFO - Running setup.py (path:/tmp/pip-Z5c4fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:38 INFO - Running setup.py (path:/tmp/pip-j6hjl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:38 INFO - Running setup.py (path:/tmp/pip-gdXh3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:38 INFO - Running setup.py (path:/tmp/pip-yQfjDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:38 INFO - Running setup.py (path:/tmp/pip-dtQjCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:38 INFO - Running setup.py (path:/tmp/pip-epyUxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:38 INFO - Running setup.py (path:/tmp/pip-vylolw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:39 INFO - Running setup.py (path:/tmp/pip-GkNrAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:39 INFO - Running setup.py (path:/tmp/pip-7_0OVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:39 INFO - Running setup.py (path:/tmp/pip-qBNsTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:39 INFO - Running setup.py (path:/tmp/pip-r3jujG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:39 INFO - Running setup.py (path:/tmp/pip-VxKuEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:36:39 INFO - Running setup.py install for manifestparser 23:36:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:36:39 INFO - Running setup.py install for mozcrash 23:36:39 INFO - Running setup.py install for mozdebug 23:36:39 INFO - Running setup.py install for mozdevice 23:36:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:36:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:36:39 INFO - Running setup.py install for mozfile 23:36:39 INFO - Running setup.py install for mozhttpd 23:36:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:36:39 INFO - Running setup.py install for mozinfo 23:36:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for mozInstall 23:36:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for mozleak 23:36:40 INFO - Running setup.py install for mozlog 23:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for moznetwork 23:36:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for mozprocess 23:36:40 INFO - Running setup.py install for mozprofile 23:36:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for mozrunner 23:36:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:36:40 INFO - Running setup.py install for mozscreenshot 23:36:40 INFO - Running setup.py install for moztest 23:36:41 INFO - Running setup.py install for mozversion 23:36:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:36:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:36:41 INFO - Cleaning up... 23:36:41 INFO - Return code: 0 23:36:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:41 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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:41 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 23:36:41 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 23:36:41 INFO - Using env: {'DISPLAY': ':0', 23:36:41 INFO - 'HOME': '/home/cltbld', 23:36:41 INFO - 'LANG': 'en_US.UTF-8', 23:36:41 INFO - 'LANGUAGE': 'en_US:en', 23:36:41 INFO - 'LOGNAME': 'cltbld', 23:36:41 INFO - 'MAIL': '/var/mail/cltbld', 23:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:41 INFO - 'MOZ_NO_REMOTE': '1', 23:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:41 INFO - 'NO_EM_RESTART': '1', 23:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:41 INFO - 'PWD': '/builds/slave/test', 23:36:41 INFO - 'SHELL': '/bin/bash', 23:36:41 INFO - 'SHLVL': '1', 23:36:41 INFO - 'TERM': 'linux', 23:36:41 INFO - 'TMOUT': '86400', 23:36:41 INFO - 'USER': 'cltbld', 23:36:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:41 INFO - '_': '/tools/buildbot/bin/python'} 23:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:41 INFO - Running setup.py (path:/tmp/pip-pmeSLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:41 INFO - Running setup.py (path:/tmp/pip-DBLS_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:41 INFO - Running setup.py (path:/tmp/pip-MGjI4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:41 INFO - Running setup.py (path:/tmp/pip-zst0nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:41 INFO - Running setup.py (path:/tmp/pip-hprYpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:41 INFO - Running setup.py (path:/tmp/pip-0pSMri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:41 INFO - Running setup.py (path:/tmp/pip-7IGZsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:41 INFO - Running setup.py (path:/tmp/pip-YL3vfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:41 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)) 23:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:41 INFO - Running setup.py (path:/tmp/pip-9YNrmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:42 INFO - Running setup.py (path:/tmp/pip-9Fgpkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:42 INFO - Running setup.py (path:/tmp/pip-8gOQ84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:42 INFO - Running setup.py (path:/tmp/pip-Ve5POf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:42 INFO - Running setup.py (path:/tmp/pip-ahIDTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:42 INFO - Running setup.py (path:/tmp/pip-RHhEHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:42 INFO - Running setup.py (path:/tmp/pip-vqWtqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:42 INFO - Running setup.py (path:/tmp/pip-S3VwV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:42 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)) 23:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:42 INFO - Running setup.py (path:/tmp/pip-Md6MWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:42 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)) 23:36:42 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)) 23:36:42 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)) 23:36:42 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)) 23:36:42 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)) 23:36:42 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)) 23:36:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:36:42 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 23:36:42 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 23:36:42 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 23:36:42 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 23:36:42 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 23:36:42 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 23:36:44 INFO - Downloading blessings-1.6.tar.gz 23:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:36:44 INFO - Installing collected packages: blessings 23:36:44 INFO - Running setup.py install for blessings 23:36:44 INFO - Successfully installed blessings 23:36:44 INFO - Cleaning up... 23:36:44 INFO - Return code: 0 23:36:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:45 INFO - Reading from file tmpfile_stdout 23:36:45 INFO - Current package versions: 23:36:45 INFO - argparse == 1.2.1 23:36:45 INFO - blessings == 1.6 23:36:45 INFO - blobuploader == 1.2.4 23:36:45 INFO - docopt == 0.6.1 23:36:45 INFO - functools32 == 3.2.3-2 23:36:45 INFO - jsonschema == 2.5.1 23:36:45 INFO - manifestparser == 1.1 23:36:45 INFO - mozInstall == 1.12 23:36:45 INFO - mozcrash == 0.17 23:36:45 INFO - mozdebug == 0.1 23:36:45 INFO - mozdevice == 0.48 23:36:45 INFO - mozfile == 1.2 23:36:45 INFO - mozhttpd == 0.7 23:36:45 INFO - mozinfo == 0.9 23:36:45 INFO - mozleak == 0.1 23:36:45 INFO - mozlog == 3.2 23:36:45 INFO - moznetwork == 0.27 23:36:45 INFO - mozprocess == 0.23 23:36:45 INFO - mozprofile == 0.28 23:36:45 INFO - mozrunner == 6.12 23:36:45 INFO - mozscreenshot == 0.1 23:36:45 INFO - mozsystemmonitor == 0.3 23:36:45 INFO - moztest == 0.7 23:36:45 INFO - mozversion == 1.4 23:36:45 INFO - psutil == 3.1.1 23:36:45 INFO - requests == 1.2.3 23:36:45 INFO - wsgiref == 0.1.2 23:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:45 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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:45 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 23:36:45 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 23:36:45 INFO - Using env: {'DISPLAY': ':0', 23:36:45 INFO - 'HOME': '/home/cltbld', 23:36:45 INFO - 'LANG': 'en_US.UTF-8', 23:36:45 INFO - 'LANGUAGE': 'en_US:en', 23:36:45 INFO - 'LOGNAME': 'cltbld', 23:36:45 INFO - 'MAIL': '/var/mail/cltbld', 23:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:45 INFO - 'MOZ_NO_REMOTE': '1', 23:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:45 INFO - 'NO_EM_RESTART': '1', 23:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:45 INFO - 'PWD': '/builds/slave/test', 23:36:45 INFO - 'SHELL': '/bin/bash', 23:36:45 INFO - 'SHLVL': '1', 23:36:45 INFO - 'TERM': 'linux', 23:36:45 INFO - 'TMOUT': '86400', 23:36:45 INFO - 'USER': 'cltbld', 23:36:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:45 INFO - '_': '/tools/buildbot/bin/python'} 23:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 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)) 23:36:45 INFO - Cleaning up... 23:36:45 INFO - Return code: 0 23:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:36:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:45 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 0x184c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', '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 23:36:45 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 23:36:45 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 23:36:45 INFO - Using env: {'DISPLAY': ':0', 23:36:45 INFO - 'HOME': '/home/cltbld', 23:36:45 INFO - 'LANG': 'en_US.UTF-8', 23:36:45 INFO - 'LANGUAGE': 'en_US:en', 23:36:45 INFO - 'LOGNAME': 'cltbld', 23:36:45 INFO - 'MAIL': '/var/mail/cltbld', 23:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:45 INFO - 'MOZ_NO_REMOTE': '1', 23:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:45 INFO - 'NO_EM_RESTART': '1', 23:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:45 INFO - 'PWD': '/builds/slave/test', 23:36:45 INFO - 'SHELL': '/bin/bash', 23:36:45 INFO - 'SHLVL': '1', 23:36:45 INFO - 'TERM': 'linux', 23:36:45 INFO - 'TMOUT': '86400', 23:36:45 INFO - 'USER': 'cltbld', 23:36:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:45 INFO - '_': '/tools/buildbot/bin/python'} 23:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:36:45 INFO - Cleaning up... 23:36:45 INFO - Return code: 0 23:36:45 INFO - Running post-action listener: _resource_record_post_action 23:36:45 INFO - Running post-action listener: _start_resource_monitoring 23:36:45 INFO - Starting resource monitoring. 23:36:45 INFO - ##### 23:36:45 INFO - ##### Finished create-virtualenv step (success) 23:36:45 INFO - ##### 23:36:45 INFO - ##### 23:36:45 INFO - ##### Running install step. 23:36:45 INFO - ##### 23:36:45 INFO - Running pre-action listener: _resource_record_pre_action 23:36:45 INFO - Running main action method: install 23:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:45 INFO - Reading from file tmpfile_stdout 23:36:45 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:45 INFO - Reading from file tmpfile_stdout 23:36:45 INFO - Output received: 23:36:45 INFO - Usage: mozinstall [options] installer 23:36:45 INFO - Options: 23:36:45 INFO - -h, --help show this help message and exit 23:36:45 INFO - -d DEST, --destination=DEST 23:36:45 INFO - Directory to install application into. [default: 23:36:45 INFO - "/builds/slave/test"] 23:36:45 INFO - --app=APP Application being installed. [default: firefox] 23:36:45 INFO - mkdir: /builds/slave/test/build/application 23:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:37:02 INFO - Reading from file tmpfile_stdout 23:37:02 INFO - Output received: 23:37:02 INFO - /builds/slave/test/build/application/firefox/firefox 23:37:02 INFO - Running post-action listener: _resource_record_post_action 23:37:02 INFO - ##### 23:37:02 INFO - ##### Finished install step (success) 23:37:02 INFO - ##### 23:37:02 INFO - ##### 23:37:02 INFO - ##### Running run-tests step. 23:37:02 INFO - ##### 23:37:02 INFO - Running pre-action listener: _resource_record_pre_action 23:37:02 INFO - Running main action method: run_tests 23:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:37:02 INFO - Python 2.7.3 23:37:02 INFO - Return code: 0 23:37:02 INFO - grabbing minidump binary from tooltool 23:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:02 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 0x1b0b3b0>, '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 0x1b0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:37:02 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 23:37:02 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 23:37:02 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 23:37:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:37:02 INFO - Return code: 0 23:37:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:37:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:37:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:37:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:37:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 23:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 23:37:02 INFO - Using env: {'DISPLAY': ':0', 23:37:02 INFO - 'HOME': '/home/cltbld', 23:37:02 INFO - 'LANG': 'en_US.UTF-8', 23:37:02 INFO - 'LANGUAGE': 'en_US:en', 23:37:02 INFO - 'LOGNAME': 'cltbld', 23:37:02 INFO - 'MAIL': '/var/mail/cltbld', 23:37:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:37:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:02 INFO - 'MOZ_NO_REMOTE': '1', 23:37:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:02 INFO - 'NO_EM_RESTART': '1', 23:37:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:02 INFO - 'PWD': '/builds/slave/test', 23:37:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:37:02 INFO - 'SHELL': '/bin/bash', 23:37:02 INFO - 'SHLVL': '1', 23:37:02 INFO - 'TERM': 'linux', 23:37:02 INFO - 'TMOUT': '86400', 23:37:02 INFO - 'USER': 'cltbld', 23:37:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132', 23:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:02 INFO - '_': '/tools/buildbot/bin/python'} 23:37:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 23:37:02 INFO - mozversion application_buildid: 20160708221526 23:37:02 INFO - mozversion application_changeset: e3dcf062007e280ccf06e7bed7ff904d0fb44418 23:37:02 INFO - mozversion application_display_name: Nightly 23:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:37:02 INFO - mozversion application_name: Firefox 23:37:02 INFO - mozversion application_remotingname: firefox 23:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:37:02 INFO - mozversion application_vendor: Mozilla 23:37:02 INFO - mozversion application_version: 50.0a1 23:37:02 INFO - mozversion platform_buildid: 20160708221526 23:37:02 INFO - mozversion platform_changeset: e3dcf062007e280ccf06e7bed7ff904d0fb44418 23:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:37:02 INFO - mozversion platform_version: 50.0a1 23:37:02 INFO - using testdate: 1468046222 23:37:02 INFO - actual date: 1468046222 23:37:02 INFO - starting webserver on 'localhost:47941' 23:37:02 INFO - SUITE-START | Running 2 tests 23:37:02 INFO - TEST-START | dromaeo_css 23:37:02 INFO - operating with platform_type : linux_ 23:37:02 INFO - Initialising browser for dromaeo_css test... 23:37:02 INFO - TEST-INFO | started process 5114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJgfnh/profile http://localhost:47941/getInfo.html) 23:37:07 INFO - PROCESS | 5114 | __metrics Screen width/height:1600/1200 23:37:07 INFO - PROCESS | 5114 | colorDepth:24 23:37:07 INFO - PROCESS | 5114 | Browser inner width/height: 1024/697 23:37:07 INFO - PROCESS | 5114 | __metrics 23:37:08 INFO - PROCESS | 5114 | 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" 23:37:08 INFO - PROCESS | 5114 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:37:09 INFO - TEST-INFO | 5114: exit 0 23:37:09 INFO - Browser initialized. 23:37:09 INFO - Running cycle 1/1 for dromaeo_css test... 23:37:09 INFO - TEST-INFO | started process 5195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJgfnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:21 INFO - PROCESS | 5195 | RSS: Main: 159051776 23:37:21 INFO - PROCESS | 5195 | 23:38:12 INFO - PROCESS | 5195 | 1468046292869 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] 23:40:25 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47941/tests/dromaeo/cssquery-ext.html) 23:40:26 INFO - PROCESS | 5195 | RSS: Main: 251981824 23:40:26 INFO - PROCESS | 5195 | 23:43:29 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-ext.html (next: http://localhost:47941/tests/dromaeo/cssquery-jquery.html) 23:43:29 INFO - PROCESS | 5195 | RSS: Main: 245243904 23:43:29 INFO - PROCESS | 5195 | 23:46:32 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47941/tests/dromaeo/cssquery-mootools.html) 23:46:32 INFO - PROCESS | 5195 | RSS: Main: 245878784 23:46:32 INFO - PROCESS | 5195 | 23:49:34 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47941/tests/dromaeo/cssquery-prototype.html) 23:49:35 INFO - PROCESS | 5195 | RSS: Main: 238690304 23:49:35 INFO - PROCESS | 5195 | 23:52:38 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47941/tests/dromaeo/cssquery-yui.html) 23:52:38 INFO - PROCESS | 5195 | RSS: Main: 218832896 23:52:38 INFO - PROCESS | 5195 | 23:55:41 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:47941/tests/dromaeo/cssquery-yui.html (next: http://localhost:47941/tests/dromaeo/cssquery-dojo.html) 23:55:42 INFO - PROCESS | 5195 | RSS: Main: 303849472 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | __start_tp_report 23:55:42 INFO - PROCESS | 5195 | _x_x_mozilla_page_load 23:55:42 INFO - PROCESS | 5195 | _x_x_mozilla_page_load_details 23:55:42 INFO - PROCESS | 5195 | |i|pagename|runs| 23:55:42 INFO - PROCESS | 5195 | |0;dojo.html;2570.4088059746255;2573.613957906315;2606.37447012717;2614.529384710752;2618.4239467317198;4580.152671755719;4630.907381852365;4634.745089020107;4639.443266807979;4690.624750019999;4657.767111644413;4694.037722266936;4735.73953432561;4745.667803253774;4769.022350418165;4278.208531421689;4286.549912259215;4322.28682267427;4362.214801335758;4366.825326986933;4375.540568240337;4414.801333939964;4447.555244475543;4461.219286624844;4469.994251293466;4231.597998190167;4297.376880352363;4302.763348015857;4363.890902727426;4390.407295015164;4327.891802704926;4344.261475549132;4350.782460876975;4352.260115780325;4352.521222665504;4282.50751163617;4320.913581728348;4321.0709697415205;4331.675124365685;4371.650267978586;4573.611243044345;4596.609288210473;4620.792064357079;4707.8587642370785;4796.952030479685;4948.455669876311;4986.10250154972;4986.551210391046;4988.65079444439;4992.126377883892;4900;4972.105021096201;5019.19692849146;5019.397672279313;5026.396832380138;4666.136764698542;4671.392718946515;4672.836450724209;4714.434267887876;4715.339852420664;5138.126518491866;5141.897162056813;5173.482651734872;5174.456682048406;5175.560077393464;4768.141734487756;4893.681910675795;4948.802047918043;4952.752362381866;4953.578945789576;5024.120778863684;5051.696898186121;5085.084684756705;5091.490850914953;5091.770870310845;4978.1288274552535;4986.252062190701;4989.725565093955;4998.750062496861;5049.772760225798;4817.349657796222;4906.58294045003;4965.90068198634;4973.1297023020825;4977.32806071183;4191;4195.412642230091;4197.139586384784;4208.116295577902;4244.384564238168;3649.7445178837756;3687.3547129252274;3706.4069748840056;3710.424884142962;3719.9442008369897;4240.639545638655;4270.466191726035;4314.288142456459;4323.2434323993175;4330.112326972963;5024.070546948826;5032.84901452957;5038.521340472649;5039.571636410873;5070.340855688737;4219.873403797891;4312.805923733376;4324.243257429937;4325.329573916048;4367.694261401735;4430.8449204277695;4447.2439685253585;4477.731336119843;4480.641548676163;4485.102979404132;4664.3469914211355;4669.252919532994;4671.15919134559;4689.695169814019;4715.740634265148;4900.215965445655;4925.704457732548;4991.5258050485145;4993.625478089085;4996.925046124384;4632.397788287636;4664.836730714409;4677.391939047902;4695.36612557314;4727.645426593088;4942.8022879085875;4953.108440480748;4960;4963.354763880672;4996.275540046746;4853.150698627655;4938.530839570235;4976.651634385558;5032.0690672225755;5060.595152387874;4866.221404575251;4870.1964175912;4891.413030436228;4914.508549145057;4924.704517728947;4869.293952376956;4877;4878.048780487913;4886.389201349832;4928.67963582366;4661.230896901973;4751.6436267279405;4804.039192161652;4884;4890.364252647133;4967.230079337708;4967.7019378837385;4979.053979743837;4989.25161225819;5027.974860125676;4855.150348689036;4869;4870.147724148331;4873.585745211697;4926.827561035347 23:55:42 INFO - PROCESS | 5195 | |1;ext.html;572.4247131632709;573.7848306884918;581.0006788324081;585.4233579923774;585.4964730331914;40920.38619420707;42546.787266063664;42699;45946;46106.769466152626;43756;44202.11595768083;44206.77896610512;44265.55734442655;44292;7557.244275572454;7943.768715849038;8083.595820208995;8089.595520223966;10087.04173103554;10048.598056077784;10385.376877387343;10386.844197337046;10393.53229104692;10398.168146548258;10420.905804890492;10450.268481206318;10467.31962422444;10475.109615682675;10477.109445697086;7662.157162712125;10081.092701656813;10329.276950613461;10335.94832025835;10379.377237365745;10247.897521024768;10306.484675766256;10310.587576496931;10318.1745460363;10324.380537167794;40161.79919100415;40470;40510;40541;40551.797241013905;2610.830296030752;2760.6963234044238;3046.086174147769;3278.409886220479;3451.8274086295582;29853.701462985526;30243.0927072186;30288.54567181494;30461.23846903823;30796.076117716504;3270.2641905571295;3443.276911848515;3450.102973226954;3456.8962931112105;3502.544669193014;256501;256559;257091;257954;258810.9999999981;48809.75595122073;50030.74984625054;50282.74858625756;50292.74853625709;55615.72192139013;54545;58105.70947145322;58182.7090864543;58220.417795822344;58236;14497.782533262009;14498.710025799635;14586.051906626035;14598.854011459749;14602.48891288821;10290.3825770454;10455.94772026135;10460.68617941463;10577.629782957714;10581.947090264654;17391;17749.911250443663;17791.19939602721;17853.910730446525;17857.821421785615;5788.3343415506915;5870.3249126350165;5933.762649494059;5944.5838791284195;5960.910586341209;700.1248439450686;788.8225149341353;796.7689370082727;832.5337810825957;910.1035480052143;25955.221343359728;26946.595801063;27166.456670866868;27671.58492622612;27879.721202788118;818.1532114261711;826.3595713322223;864.9351298652626;904.9954750226207;929.3958926697566;13749.31253437324;14045;14284.57146285613;14418.06080230264;14498.782518262235;377775;383812;384036;384533;384590;50710.492895071315;50967;51067.489325106275;51103.48896510987;51134.74432627813;1067.7330667333167;1095.085603521037;1107.0977153619936;1185.8102703567388;1208.8938621161715;23927.76072239325;29676;29685.40629187361;31693.841530792197;32996.1750956228;49023.754881225366;49592.504074958786;49691.254631179836;49766.50233497618;49902.750486247336;355669;361734;362106;362795;363624;28894.566581501716;31877.840610797724;34680.65319346875;34824.12939676528;37791;41164.794176028925;41188.38217426681;41473.1705365897;42392.788036059625;42589.787051064544;35393.82303088468;35825.82087089548;36028.279434410644;36245.63754362422;36290.455643164845;35556;35819.82090089533;35880.820595897894;35975.820120899225;36030.279394412486;34484.82757586196;35553;35764;35894;35913.46129808003;30608.540871886493;31806.863163325328;31979;32028.359432811678;32356.191095222806;24530.14144504934;24619.13833015836;24638.13766518163;24750.876245618656;25203.369915752253 23:55:42 INFO - PROCESS | 5195 | |2;jquery.html;366.9302832461832;367.81057755256046;368.8727389050777;377.11566376846287;379.2453018493198;16424.260908259126;17333.39333123341;18164.727529087075;18182.454526364196;18188.999605021734;16519.91740041298;17135.485935421926;17263.39578114766;17873.19570619322;17913.104344782772;4652.1858674731875;4817.470078291385;4829.710217386951;4856.101621200071;4856.247281671329;3542.2738338640515;3669.156094098359;4757.310190022445;6024;6327.8418039548915;6309.3375195604485;6351.015592583134;6391.105245265667;6392.680365981706;6394.616323020634;5673.602847800656;5762.567807414461;5769;5770.971145144289;5775.249217601727;3413.84637691302;4987.975060124712;5287.68273903567;5294.973525132388;5573.554115670777;11135.05352045077;11137.443127843575;11176.497057632427;11228.887711122947;11963.760724785456;1896.6111947050958;1900.9049547522707;1923.778765441978;1923.8653294269407;2028.1177687705895;9316.534173291377;9376.390534615228;9395.577199025993;9783.217342612645;9873;1702.702027145257;1758.753774471575;1792.8744987850855;1828.6122281005323;1832.6426346862368;39745.60254397448;40110.19779604421;40218;40349.193016139805;59661.403385966456;9576.329656924088;9791.951040244754;9916.702498925044;10217.489125543842;10408.063274305348;13493.190408575518;13567.59297221085;13585.45658173662;13617.931910340385;13719.725605488034;7114.324139206767;7115.075040244838;7178.066851309401;7244.239354867768;7330.193678695339;6523.380278873499;6650.53446258767;6791;6961.477889158334;7147.749828755968;3922.980025193413;4221.409002739619;4295.098029413795;4359.455068116486;4361.978190109093;1569.1918661889135;1666.31681010785;1728.08411541883;1795.371619933013;1821.317006122704;756.6292516666794;817.2930415190817;845.7970087179033;913.4245425381966;935.2190920581255;16795.83204167967;17543.73684394735;17564.91217543904;17718.025508596893;18073.909630452028;830.2278880641062;837.8533756592572;840.3865178419787;851.9531425771642;930.418488444722;9696.321257511907;10004.399736015717;10022.599096036078;10097.141742951784;10210.948945255375;394263;397221;398273;402569;402680;55708.44291557113;81168.59415702884;81595.11040536915;81837;81910.59044704738;862.1895418306772;874.9737507874773;891.1667590802491;894.3515950935649;895.54327293081;15425.479196812907;15602.375904964128;15818.288177032291;15883.761743573625;16236.51290461288;37148.07129821668;37225.627743722216;37735;38752.41871371988;39247;49743.75128124336;52093.21860172025;53360.46639533555;54344;54421.45578544164;5344.9732751336;7463.141738700119;7739.374731306489;7795;8096.757097287091;10200.59197632116;12205;12223.877761222275;12229.510819567118;12266.080043996915;10231.079202871777;10317.690469285933;10819.945900270448;10915.34507929495;11155.27490713101;9389.10803473669;9897.901020989699;10146.137578305927;10621.681349559525;10723.94638026805;10342.224333175192;10449.634262800766;10467.267291289536;10496.422696751752;11170;7996.84006319882;8011.319037881845;8050.677972881019;8065.596720163851;8267.751967440987;9649.565769540248;10344.741381465523;10364.735108441118;10433.739156520844;10675.306105103144 23:55:42 INFO - PROCESS | 5195 | |3;mootools.html;1376.862313768623;1412.0186470403069;1464.223961300511;1672.6905522478341;1682.1084825042717;7631.313181813635;8052.315553177987;8154.633041513124;8155.266026057654;8162.673493060278;6522.70647820848;6702.296258892819;6710.027046078316;6844.555103918255;7929.484583502069;2130.648443006902;2221.0782525252002;2227.0646328542052;2231.9218827341047;2235.854669446489;2226.565819665166;2228.7771222877745;2237.015713086245;2259.5029093599464;2261.0955617752948;1877.9530511737248;2163.491579478821;2217.3347995601334;2240.047979608668;2243.3942835434423;2184.1045171479695;2212.281008672172;2215.700880381144;2215.7119574455296;2216.4015715756655;2151.354593621907;2160.7731188225166;2171.283476452767;2186.1146235774536;2189;7714;7810.843783124363;7819.609019549;7826.1391246962785;7836.138024817265;4491.39366185564;4602.769861506911;4611.608013318872;4637.559431853969;4646.697964632322;2853.1155341844096;2917.547780094089;2955.3202763364548;2955.5566665000206;2964.6887076856833;888.9866652000226;889.4796544021755;915.3501014279802;916.6104405627648;919.14978644754;10987.890121098766;10999.34003959757;11000.22998390113;11006.559737610485;11008.559657613685;4194.727342722713;4242.469691288589;4383.473983122046;4385.978070109629;4390.429244198233;9409.059094090537;9421.434713917188;9423.811523769486;9427.858582121273;9429.245660347156;4579.358889755437;4583.747893865802;4585.70192937458;4588.082383523309;4593.173228818778;3510.78935263885;4159.417681524589;4165.604267594574;4166.166766646622;4166.416701661769;3564;3724.2365315110337;3738.476613274144;3742.120601658608;3800.8289626966853;1160.048760016778;1161.73280145567;1183.7040739815047;1187.9465424055938;1193.4868006757179;703.5286358140058;791.0388877513848;825.6903661127077;825.8059356051323;849.1593322610571;5241.50205730455;5395;5423.267858839085;5450.945490545044;5550.8057217997175;816.1145157504175;865.6018231613402;871.5642178910545;890.7995700967231;901.9278457723366;3570.4822800693755;3686.5207523022373;3700.907477313035;3722.2927643747603;3722.4230244312175;9459.24326053914;9734.41593504392;9957.900420995697;9970.950145249228;9972.451515166591;9261.16649501548;9709.805803883883;9715.70852874415;10000.14998725102;10006.849897251546;7291.963540182265;7363.300486453778;7515.135759387631;7543.9622801886735;7555.584442855696;5242.135047717084;5280.471952804689;5386.192071189353;5458;5460.31746031746;8697.304215662858;8949.507777072324;8957.641694332415;8973.32700047486;8979.326550508607;8923.15230053144;8928.500614664772;8965.865512017195;9047.321450891079;9123.635054597742;6327.746890124527;6568.343165683394;6929.3070692930305;7048.224695283412;7115.217326094229;7232.566046037255;7256.818579535554;7317.158526769277;7317.414606831334;7342.559446433231;6435.32429094957;6681.33186681328;6683.532152749261;6710.597364158166;6735.461163106842;6583.736650533925;6635.834104147242;6752.561083529555;6756.864862702817;6779.423748981392;6390.808275751735;6402.263739669997;6441.323661015714;6445.1943507061615;6450.967745161244;4261.957380426156;4468.687191896536;4497.730136191839;4515.90968180628;4535.637149028136;4493.662975276802;4528.252838281646;4583.472900616472;4590.127875703739;4603.953960460352 23:55:42 INFO - PROCESS | 5195 | |4;prototype.html;287.0627401533992;290.85602626699784;294.8525737131434;294.92037149969525;295.9260184953762;4861;4915.803367865281;4920.286558449023;4927.950720492794;4933.654644174909;4818.783154758035;4827.106985207739;4831.710097394159;4891.559759621633;4894.702903730515;3572.535570375854;3651.598324184338;3668.816559172031;3804.182100848317;3833.7508061976023;3772.226693527834;3790.867319643813;3792.374258247386;3799.6580307772297;3841.78870162141;3573.589037260709;3743.88768336949;3753.155540003491;3772.9622703772884;3787.9810600946957;3642.708583313342;3734.477173195755;3777.8866634001024;3781.3949768037255;3784.8864534064023;3314.3371325734947;3326.2183386904057;3326.6673332666783;3340.5490258814993;3350.1959529712935;4794.232922732381;4798.760061996921;4800.759962001921;4801.903961920777;4814.422269327703;4228.957710422918;4301.311790113598;4311.1808756336195;4330.177266319421;4331.6534677225745;4964.578010869081;4991.675541089818;5045.117104506697;5061.873453163664;5078.619103567247;3588.1926566522584;3604.9725828138853;3606.350856845767;3613.313470440608;3616.7341430499378;5207.739613019372;5213.947860521384;5280.683159010472;5348.491893270172;5353.116735738598;3644.890653280406;3659.505966694462;3666.2667466506273;3669.633036696309;3694.4827724118645;3701.3522633539023;3739.8504059837846;3747;3748.775073495599;3759.721694623841;4258.53156152823;4276.828926842892;4284.8500302489265;4292.463442069741;4297.140571885635;4937.902438051905;5003.174476211457;5041.495850414929;5044.344235249468;5047.772850221675;1268.2327192048863;1279.8912092472244;1285.4279845468864;1285.736424033071;1294.6116165150418;841.1924552429736;841.7432683031734;872.1235158665501;895.1183084661603;900.8648702694649;4412.4043254160915;4412.624926881187;4444.799984000728;4491.169133710274;4500.819967201275;5072.442031376546;5089.389273287229;5158.509941555546;5193.402758682724;5200.167973124282;4241.97879010603;4413.845515406945;4418.536053714378;4427.601515863587;4461.754603496839;2735.411886444384;2738.288045108286;2746.4507098580366;2753.435545713124;2759.5374451540315;4814.350062741555;4816.8554943351755;4831.903361932812;4832.057748739033;4844.32179494871;5117;5229.111051121318;5267.736613169326;5302.761375738101;5305.681659100389;4798.704349825458;4820.975190420032;4825.95174048262;4834.975825120852;4843.754684361556;5102.4897510248675;5132.666376685504;5132.871678208075;5147.871303217449;5175.870603234949;4888.800039981951;5062.974685126551;5064.341635587498;5185.222216667379;5192.896142077213;4915.827946022016;4919.065377578248;4922.729249891147;4926.8768280793265;4933.851984440473;3649.6897763690386;3678.4114541673202;3679.356112680324;3682.834272457799;3703.333399988028;5153.866149447265;5313.229581710708;5351.705656188947;5352.304200453916;5353.759080841293;5071;5102.3722782767645;5117.437081920912;5124.79500819978;5133.307003554472;5116.334876466036;5119.360079990001;5120.18077107661;5121.974390128025;5123.077845987758;4915.557599816034;5052.368453943257;5054.1155297822;5056.356684077616;5074.898502029865;4935.383077115361;4959.652824302264;5121.487851214998;5128.743562821918;5139.152039913372;5013.674111182761;5020.648554601143;5028.321176641107;5056.064628043824;5065.518775716301 23:55:42 INFO - PROCESS | 5195 | |5;yui.html;621.5617989317532;661.9867602647951;687.1959807025783;695.9930400695991;706.9752558660448;12210.267383956969;12835.935820320885;12839.871601283985;12844.165129266603;12855.292958887258;12850.164739291962;13056.477740890377;13074.73850522989;13121.14712543684;13130.474781008772;620.664840985867;773.1804287455316;774.5043172369687;794.7695168401157;798.4690181029608;786.626352482569;794.7297918707638;797.131127071492;797.4457751862458;797.5214871077366;835.9498430094184;837.8659414493683;837.9958100209491;838.6310023589632;842.8988521377444;657.8782925158837;671.2783757460701;673.7002034094829;675.9256481786999;841.6969890839293;590.6898878088995;602.7528713227599;606.3542327421283;609.7500024989733;610.6854969690613;13562.321883905865;13564.525241616595;13591.592252232449;13600.115992460558;13614.18314901109;11911.344876031815;12096.213746106563;12506.562270320495;12536.623901282976;12727.363631818465;11407.712746144853;11545.13411494133;11818.17272790905;11909.344986025764;12301.938490307492;4085.428040074392;4100.5899410059055;4143.91712165755;4282.50751163617;4286.507051689065;60079;60100.39899600992;60563.69718151425;60707.39292607106;60950.39049609447;9586.616535338508;9603.423794572209;9638;9675.467849268358;9872.555734991798;18409.447716568524;18436.907815460836;18444.170012349477;18454.630907381776;18463.630727385378;6557.278699343068;6625.900611490832;6642.43539299165;6674.666266686743;6869.931300687029;3563.572371315459;3587.856485740593;3615.8011309378235;3639.454081887738;3694.51971243742;2600.726923673025;2684.1276585109918;2690.8250963687296;2691.3675286307703;2692.9596056059177;476.77829809138916;481.30932112418793;482.17547992931776;499.8225629901405;504.7249249159217;533.5891363650045;549.3901769036366;556.7077284425709;558.1655425139443;568.3861429655962;7317.304856038668;7333.633318334062;7398.556086634819;7404.370628496638;7573.053368328959;461.4605972193286;508.2630186229907;530.2205757536416;542.2760614579502;553.7397423211085;3393.8472768724973;3579.069441945113;3598.082488965297;3647.507586475792;3674.540682414698;91264.5436772812;95469;95604;97150.51424742972;98651.50674246583;84236;84272.57863710642;84484.57757711172;85672;85709.57145214234;74040;75321.62339188378;75728.56307213948;75743.62128189544;76515.23484765193;6341.904871427025;6377.330380310001;6543.214814222133;6623.304553021863;6798.524103312919;42245.577544224165;42956.57043429526;43704.12591748211;44212.55787442213;45108.32337514874;58549;61528.384716152264;62176;62802.37197627965;63353.68323158355;9903.653372132228;10035.24735644844;10155.187584993035;10168.949155254177;10433.791324173626;10499.47502624881;10704.785904282027;10706.785864282827;10734.409607471664;10830.49078314548;7069.9646501767165;9961.452120133463;10104.747381315527;10184.847227291448;11003.504842281956;11723.589674361356;11845;11962.461689223832;12200.75598488043;12973.610791676265;10759.408232547285;11086.168537359892;11098.223124381217;11357.204995650225;11500.137489688139;9823.383009985295;10347.844240538381;10741.033307002408;10770.623028193975;10890.673279801618;9627;10037.648682296085;10780.137588993019;10820.89179108199;10877 23:55:42 INFO - PROCESS | 5195 | __end_tp_report 23:55:42 INFO - PROCESS | 5195 | __start_cc_report 23:55:42 INFO - PROCESS | 5195 | _x_x_mozilla_cycle_collect,958 23:55:42 INFO - PROCESS | 5195 | __end_cc_report 23:55:42 INFO - PROCESS | 5195 | __startTimestamp1468047342020__endTimestamp 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | ------- Summary: start ------- 23:55:42 INFO - PROCESS | 5195 | Number of tests: 6 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#0] dojo.html Cycles:165 Average:4630.01 Median:4735.74 stddev:487.35 (10.3%) stddev-sans-first:461.28 23:55:42 INFO - PROCESS | 5195 | Values: 2570.4 2573.6 2606.4 2614.5 2618.4 4580.2 4630.9 4634.7 4639.4 4690.6 4657.8 4694.0 4735.7 4745.7 4769.0 4278.2 4286.5 4322.3 4362.2 4366.8 4375.5 4414.8 4447.6 4461.2 4470.0 4231.6 4297.4 4302.8 4363.9 4390.4 4327.9 4344.3 4350.8 4352.3 4352.5 4282.5 4320.9 4321.1 4331.7 4371.7 4573.6 4596.6 4620.8 4707.9 4797.0 4948.5 4986.1 4986.6 4988.7 4992.1 4900.0 4972.1 5019.2 5019.4 5026.4 4666.1 4671.4 4672.8 4714.4 4715.3 5138.1 5141.9 5173.5 5174.5 5175.6 4768.1 4893.7 4948.8 4952.8 4953.6 5024.1 5051.7 5085.1 5091.5 5091.8 4978.1 4986.3 4989.7 4998.8 5049.8 4817.3 4906.6 4965.9 4973.1 4977.3 4191.0 4195.4 4197.1 4208.1 4244.4 3649.7 3687.4 3706.4 3710.4 3719.9 4240.6 4270.5 4314.3 4323.2 4330.1 5024.1 5032.8 5038.5 5039.6 5070.3 4219.9 4312.8 4324.2 4325.3 4367.7 4430.8 4447.2 4477.7 4480.6 4485.1 4664.3 4669.3 4671.2 4689.7 4715.7 4900.2 4925.7 4991.5 4993.6 4996.9 4632.4 4664.8 4677.4 4695.4 4727.6 4942.8 4953.1 4960.0 4963.4 4996.3 4853.2 4938.5 4976.7 5032.1 5060.6 4866.2 4870.2 4891.4 4914.5 4924.7 4869.3 4877.0 4878.0 4886.4 4928.7 4661.2 4751.6 4804.0 4884.0 4890.4 4967.2 4967.7 4979.1 4989.3 5028.0 4855.2 4869.0 4870.1 4873.6 4926.8 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#1] ext.html Cycles:180 Average:49637.76 Median:35473.41 stddev:88973.57 (250.8%) stddev-sans-first:89146.90 23:55:42 INFO - PROCESS | 5195 | Values: 572.4 573.8 581.0 585.4 585.5 40920.4 42546.8 42699.0 45946.0 46106.8 43756.0 44202.1 44206.8 44265.6 44292.0 7557.2 7943.8 8083.6 8089.6 10087.0 10048.6 10385.4 10386.8 10393.5 10398.2 10420.9 10450.3 10467.3 10475.1 10477.1 7662.2 10081.1 10329.3 10335.9 10379.4 10247.9 10306.5 10310.6 10318.2 10324.4 40161.8 40470.0 40510.0 40541.0 40551.8 2610.8 2760.7 3046.1 3278.4 3451.8 29853.7 30243.1 30288.5 30461.2 30796.1 3270.3 3443.3 3450.1 3456.9 3502.5 256501.0 256559.0 257091.0 257954.0 258811.0 48809.8 50030.7 50282.7 50292.7 55615.7 54545.0 58105.7 58182.7 58220.4 58236.0 14497.8 14498.7 14586.1 14598.9 14602.5 10290.4 10455.9 10460.7 10577.6 10581.9 17391.0 17749.9 17791.2 17853.9 17857.8 5788.3 5870.3 5933.8 5944.6 5960.9 700.1 788.8 796.8 832.5 910.1 25955.2 26946.6 27166.5 27671.6 27879.7 818.2 826.4 864.9 905.0 929.4 13749.3 14045.0 14284.6 14418.1 14498.8 377775.0 383812.0 384036.0 384533.0 384590.0 50710.5 50967.0 51067.5 51103.5 51134.7 1067.7 1095.1 1107.1 1185.8 1208.9 23927.8 29676.0 29685.4 31693.8 32996.2 49023.8 49592.5 49691.3 49766.5 49902.8 355669.0 361734.0 362106.0 362795.0 363624.0 28894.6 31877.8 34680.7 34824.1 37791.0 41164.8 41188.4 41473.2 42392.8 42589.8 35393.8 35825.8 36028.3 36245.6 36290.5 35556.0 35819.8 35880.8 35975.8 36030.3 34484.8 35553.0 35764.0 35894.0 35913.5 30608.5 31806.9 31979.0 32028.4 32356.2 24530.1 24619.1 24638.1 24750.9 25203.4 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#2] jquery.html Cycles:180 Average:23759.04 Median:219191.60 stddev:65549.43 (29.9%) stddev-sans-first:65709.78 23:55:42 INFO - PROCESS | 5195 | Values: 366.9 367.8 368.9 377.1 379.2 16424.3 17333.4 18164.7 18182.5 18189.0 16519.9 17135.5 17263.4 17873.2 17913.1 4652.2 4817.5 4829.7 4856.1 4856.2 3542.3 3669.2 4757.3 6024.0 6327.8 6309.3 6351.0 6391.1 6392.7 6394.6 5673.6 5762.6 5769.0 5771.0 5775.2 3413.8 4988.0 5287.7 5295.0 5573.6 11135.1 11137.4 11176.5 11228.9 11963.8 1896.6 1900.9 1923.8 1923.9 2028.1 9316.5 9376.4 9395.6 9783.2 9873.0 1702.7 1758.8 1792.9 1828.6 1832.6 39745.6 40110.2 40218.0 40349.2 59661.4 9576.3 9792.0 9916.7 10217.5 10408.1 13493.2 13567.6 13585.5 13617.9 13719.7 7114.3 7115.1 7178.1 7244.2 7330.2 6523.4 6650.5 6791.0 6961.5 7147.7 3923.0 4221.4 4295.1 4359.5 4362.0 1569.2 1666.3 1728.1 1795.4 1821.3 756.6 817.3 845.8 913.4 935.2 16795.8 17543.7 17564.9 17718.0 18073.9 830.2 837.9 840.4 852.0 930.4 9696.3 10004.4 10022.6 10097.1 10210.9 394263.0 397221.0 398273.0 402569.0 402680.0 55708.4 81168.6 81595.1 81837.0 81910.6 862.2 875.0 891.2 894.4 895.5 15425.5 15602.4 15818.3 15883.8 16236.5 37148.1 37225.6 37735.0 38752.4 39247.0 49743.8 52093.2 53360.5 54344.0 54421.5 5345.0 7463.1 7739.4 7795.0 8096.8 10200.6 12205.0 12223.9 12229.5 12266.1 10231.1 10317.7 10819.9 10915.3 11155.3 9389.1 9897.9 10146.1 10621.7 10723.9 10342.2 10449.6 10467.3 10496.4 11170.0 7996.8 8011.3 8050.7 8065.6 8267.8 9649.6 10344.7 10364.7 10433.7 10675.3 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#3] mootools.html Cycles:180 Average:5163.74 Median:5390.60 stddev:2908.97 (54.0%) stddev-sans-first:2903.21 23:55:42 INFO - PROCESS | 5195 | Values: 1376.9 1412.0 1464.2 1672.7 1682.1 7631.3 8052.3 8154.6 8155.3 8162.7 6522.7 6702.3 6710.0 6844.6 7929.5 2130.6 2221.1 2227.1 2231.9 2235.9 2226.6 2228.8 2237.0 2259.5 2261.1 1878.0 2163.5 2217.3 2240.0 2243.4 2184.1 2212.3 2215.7 2215.7 2216.4 2151.4 2160.8 2171.3 2186.1 2189.0 7714.0 7810.8 7819.6 7826.1 7836.1 4491.4 4602.8 4611.6 4637.6 4646.7 2853.1 2917.5 2955.3 2955.6 2964.7 889.0 889.5 915.4 916.6 919.1 10987.9 10999.3 11000.2 11006.6 11008.6 4194.7 4242.5 4383.5 4386.0 4390.4 9409.1 9421.4 9423.8 9427.9 9429.2 4579.4 4583.7 4585.7 4588.1 4593.2 3510.8 4159.4 4165.6 4166.2 4166.4 3564.0 3724.2 3738.5 3742.1 3800.8 1160.0 1161.7 1183.7 1187.9 1193.5 703.5 791.0 825.7 825.8 849.2 5241.5 5395.0 5423.3 5450.9 5550.8 816.1 865.6 871.6 890.8 901.9 3570.5 3686.5 3700.9 3722.3 3722.4 9459.2 9734.4 9957.9 9971.0 9972.5 9261.2 9709.8 9715.7 10000.1 10006.8 7292.0 7363.3 7515.1 7544.0 7555.6 5242.1 5280.5 5386.2 5458.0 5460.3 8697.3 8949.5 8957.6 8973.3 8979.3 8923.2 8928.5 8965.9 9047.3 9123.6 6327.7 6568.3 6929.3 7048.2 7115.2 7232.6 7256.8 7317.2 7317.4 7342.6 6435.3 6681.3 6683.5 6710.6 6735.5 6583.7 6635.8 6752.6 6756.9 6779.4 6390.8 6402.3 6441.3 6445.2 6451.0 4262.0 4468.7 4497.7 4515.9 4535.6 4493.7 4528.3 4583.5 4590.1 4604.0 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#4] prototype.html Cycles:180 Average:4204.16 Median:4826.53 stddev:1224.27 (25.4%) stddev-sans-first:1191.88 23:55:42 INFO - PROCESS | 5195 | Values: 287.1 290.9 294.9 294.9 295.9 4861.0 4915.8 4920.3 4928.0 4933.7 4818.8 4827.1 4831.7 4891.6 4894.7 3572.5 3651.6 3668.8 3804.2 3833.8 3772.2 3790.9 3792.4 3799.7 3841.8 3573.6 3743.9 3753.2 3773.0 3788.0 3642.7 3734.5 3777.9 3781.4 3784.9 3314.3 3326.2 3326.7 3340.5 3350.2 4794.2 4798.8 4800.8 4801.9 4814.4 4229.0 4301.3 4311.2 4330.2 4331.7 4964.6 4991.7 5045.1 5061.9 5078.6 3588.2 3605.0 3606.4 3613.3 3616.7 5207.7 5213.9 5280.7 5348.5 5353.1 3644.9 3659.5 3666.3 3669.6 3694.5 3701.4 3739.9 3747.0 3748.8 3759.7 4258.5 4276.8 4284.9 4292.5 4297.1 4937.9 5003.2 5041.5 5044.3 5047.8 1268.2 1279.9 1285.4 1285.7 1294.6 841.2 841.7 872.1 895.1 900.9 4412.4 4412.6 4444.8 4491.2 4500.8 5072.4 5089.4 5158.5 5193.4 5200.2 4242.0 4413.8 4418.5 4427.6 4461.8 2735.4 2738.3 2746.5 2753.4 2759.5 4814.4 4816.9 4831.9 4832.1 4844.3 5117.0 5229.1 5267.7 5302.8 5305.7 4798.7 4821.0 4826.0 4835.0 4843.8 5102.5 5132.7 5132.9 5147.9 5175.9 4888.8 5063.0 5064.3 5185.2 5192.9 4915.8 4919.1 4922.7 4926.9 4933.9 3649.7 3678.4 3679.4 3682.8 3703.3 5153.9 5313.2 5351.7 5352.3 5353.8 5071.0 5102.4 5117.4 5124.8 5133.3 5116.3 5119.4 5120.2 5122.0 5123.1 4915.6 5052.4 5054.1 5056.4 5074.9 4935.4 4959.7 5121.5 5128.7 5139.2 5013.7 5020.6 5028.3 5056.1 5065.5 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - PROCESS | 5195 | [#5] yui.html Cycles:180 Average:17465.01 Median:506.49 stddev:25172.72 (4970.0%) stddev-sans-first:25211.57 23:55:42 INFO - PROCESS | 5195 | Values: 621.6 662.0 687.2 696.0 707.0 12210.3 12835.9 12839.9 12844.2 12855.3 12850.2 13056.5 13074.7 13121.1 13130.5 620.7 773.2 774.5 794.8 798.5 786.6 794.7 797.1 797.4 797.5 835.9 837.9 838.0 838.6 842.9 657.9 671.3 673.7 675.9 841.7 590.7 602.8 606.4 609.8 610.7 13562.3 13564.5 13591.6 13600.1 13614.2 11911.3 12096.2 12506.6 12536.6 12727.4 11407.7 11545.1 11818.2 11909.3 12301.9 4085.4 4100.6 4143.9 4282.5 4286.5 60079.0 60100.4 60563.7 60707.4 60950.4 9586.6 9603.4 9638.0 9675.5 9872.6 18409.4 18436.9 18444.2 18454.6 18463.6 6557.3 6625.9 6642.4 6674.7 6869.9 3563.6 3587.9 3615.8 3639.5 3694.5 2600.7 2684.1 2690.8 2691.4 2693.0 476.8 481.3 482.2 499.8 504.7 533.6 549.4 556.7 558.2 568.4 7317.3 7333.6 7398.6 7404.4 7573.1 461.5 508.3 530.2 542.3 553.7 3393.8 3579.1 3598.1 3647.5 3674.5 91264.5 95469.0 95604.0 97150.5 98651.5 84236.0 84272.6 84484.6 85672.0 85709.6 74040.0 75321.6 75728.6 75743.6 76515.2 6341.9 6377.3 6543.2 6623.3 6798.5 42245.6 42956.6 43704.1 44212.6 45108.3 58549.0 61528.4 62176.0 62802.4 63353.7 9903.7 10035.2 10155.2 10168.9 10433.8 10499.5 10704.8 10706.8 10734.4 10830.5 7070.0 9961.5 10104.7 10184.8 11003.5 11723.6 11845.0 11962.5 12200.8 12973.6 10759.4 11086.2 11098.2 11357.2 11500.1 9823.4 10347.8 10741.0 10770.6 10890.7 9627.0 10037.6 10780.1 10820.9 10877.0 23:55:42 INFO - PROCESS | 5195 | -------- Summary: end -------- 23:55:42 INFO - PROCESS | 5195 | 23:55:42 INFO - TEST-INFO | 5195: exit 0 23:55:42 INFO - TEST-OK | dromaeo_css | took 1120211ms 23:55:42 INFO - TEST-START | kraken 23:55:42 INFO - operating with platform_type : linux_ 23:55:42 INFO - Initialising browser for kraken test... 23:55:42 INFO - TEST-INFO | started process 5379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKWyvl/profile http://localhost:47941/getInfo.html) 23:55:47 INFO - PROCESS | 5379 | __metrics Screen width/height:1600/1200 23:55:47 INFO - PROCESS | 5379 | colorDepth:24 23:55:47 INFO - PROCESS | 5379 | Browser inner width/height: 1024/697 23:55:47 INFO - PROCESS | 5379 | __metrics 23:55:48 INFO - PROCESS | 5379 | 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" 23:55:48 INFO - PROCESS | 5379 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:55:49 INFO - TEST-INFO | 5379: exit 0 23:55:49 INFO - Browser initialized. 23:55:49 INFO - Running cycle 1/1 for kraken test... 23:55:49 INFO - TEST-INFO | started process 5459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKWyvl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:56:01 INFO - PROCESS | 5459 | RSS: Main: 158535680 23:56:01 INFO - PROCESS | 5459 | 23:56:04 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47941/tests/kraken/driver.html?testName=audio-beat-detection) 23:56:05 INFO - PROCESS | 5459 | RSS: Main: 217329664 23:56:05 INFO - PROCESS | 5459 | 23:56:07 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47941/tests/kraken/driver.html?testName=audio-dft) 23:56:08 INFO - PROCESS | 5459 | RSS: Main: 205012992 23:56:08 INFO - PROCESS | 5459 | 23:56:11 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47941/tests/kraken/driver.html?testName=audio-fft) 23:56:12 INFO - PROCESS | 5459 | RSS: Main: 270749696 23:56:12 INFO - PROCESS | 5459 | 23:56:14 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47941/tests/kraken/driver.html?testName=audio-oscillator) 23:56:15 INFO - PROCESS | 5459 | RSS: Main: 181420032 23:56:15 INFO - PROCESS | 5459 | 23:56:17 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:56:17 INFO - PROCESS | 5459 | RSS: Main: 186187776 23:56:17 INFO - PROCESS | 5459 | 23:56:21 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47941/tests/kraken/driver.html?testName=imaging-darkroom) 23:56:21 INFO - PROCESS | 5459 | RSS: Main: 222171136 23:56:21 INFO - PROCESS | 5459 | 23:56:25 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47941/tests/kraken/driver.html?testName=imaging-desaturate) 23:56:25 INFO - PROCESS | 5459 | RSS: Main: 217550848 23:56:25 INFO - PROCESS | 5459 | 23:56:28 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47941/tests/kraken/driver.html?testName=json-parse-financial) 23:56:29 INFO - PROCESS | 5459 | RSS: Main: 220397568 23:56:29 INFO - PROCESS | 5459 | 23:56:31 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:56:31 INFO - PROCESS | 5459 | RSS: Main: 206397440 23:56:31 INFO - PROCESS | 5459 | 23:56:33 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:56:34 INFO - PROCESS | 5459 | RSS: Main: 212119552 23:56:34 INFO - PROCESS | 5459 | 23:56:36 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:56:36 INFO - PROCESS | 5459 | RSS: Main: 209612800 23:56:36 INFO - PROCESS | 5459 | 23:56:39 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:56:40 INFO - PROCESS | 5459 | RSS: Main: 224600064 23:56:40 INFO - PROCESS | 5459 | 23:56:43 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:56:43 INFO - PROCESS | 5459 | RSS: Main: 225382400 23:56:43 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | Cycle 1(1): loaded http://localhost:47941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47941/tests/kraken/driver.html?testName=ai-astar) 23:56:45 INFO - PROCESS | 5459 | RSS: Main: 267657216 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | __start_tp_report 23:56:45 INFO - PROCESS | 5459 | _x_x_mozilla_page_load 23:56:45 INFO - PROCESS | 5459 | _x_x_mozilla_page_load_details 23:56:45 INFO - PROCESS | 5459 | |i|pagename|runs| 23:56:45 INFO - PROCESS | 5459 | |0;ai-astar;103;113;114;115;112;112;113;113;111;113 23:56:45 INFO - PROCESS | 5459 | |1;audio-beat-detection;148;124;130;168;124;127;148;122;200;121 23:56:45 INFO - PROCESS | 5459 | |2;audio-dft;162;161;163;160;164;162;163;162;162;161 23:56:45 INFO - PROCESS | 5459 | |3;audio-fft;76;76;78;123;77;77;73;75;100;75 23:56:45 INFO - PROCESS | 5459 | |4;audio-oscillator;85;87;119;85;86;87;111;85;85;122 23:56:45 INFO - PROCESS | 5459 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;116;117 23:56:45 INFO - PROCESS | 5459 | |6;imaging-darkroom;146;146;147;147;146;146;147;146;146;146 23:56:45 INFO - PROCESS | 5459 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;94 23:56:45 INFO - PROCESS | 5459 | |8;json-parse-financial;64;64;62;63;62;63;63;63;62;62 23:56:45 INFO - PROCESS | 5459 | |9;json-stringify-tinderbox;64;65;64;65;65;64;65;64;63;67 23:56:45 INFO - PROCESS | 5459 | |10;stanford-crypto-aes;81;78;79;78;80;79;83;79;78;78 23:56:45 INFO - PROCESS | 5459 | |11;stanford-crypto-ccm;139;130;128;131;132;129;131;131;191;127 23:56:45 INFO - PROCESS | 5459 | |12;stanford-crypto-pbkdf2;170;168;165;172;169;165;165;166;171;173 23:56:45 INFO - PROCESS | 5459 | |13;stanford-crypto-sha256-iterative;68;66;70;68;66;66;67;65;67;66 23:56:45 INFO - PROCESS | 5459 | __end_tp_report 23:56:45 INFO - PROCESS | 5459 | __start_cc_report 23:56:45 INFO - PROCESS | 5459 | _x_x_mozilla_cycle_collect,1873 23:56:45 INFO - PROCESS | 5459 | __end_cc_report 23:56:45 INFO - PROCESS | 5459 | __startTimestamp1468047405838__endTimestamp 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | ------- Summary: start ------- 23:56:45 INFO - PROCESS | 5459 | Number of tests: 14 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:1.17 23:56:45 INFO - PROCESS | 5459 | Values: 103.0 113.0 114.0 115.0 112.0 112.0 113.0 113.0 111.0 113.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:139.00 stddev:25.74 (18.5%) stddev-sans-first:27.19 23:56:45 INFO - PROCESS | 5459 | Values: 148.0 124.0 130.0 168.0 124.0 127.0 148.0 122.0 200.0 121.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 23:56:45 INFO - PROCESS | 5459 | Values: 162.0 161.0 163.0 160.0 164.0 162.0 163.0 162.0 162.0 161.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:16.03 (21.1%) stddev-sans-first:16.80 23:56:45 INFO - PROCESS | 5459 | Values: 76.0 76.0 78.0 123.0 77.0 77.0 73.0 75.0 100.0 75.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.00 stddev:15.53 (18.3%) stddev-sans-first:16.02 23:56:45 INFO - PROCESS | 5459 | Values: 85.0 87.0 119.0 85.0 86.0 87.0 111.0 85.0 85.0 122.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:56:45 INFO - PROCESS | 5459 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:56:45 INFO - PROCESS | 5459 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:56:45 INFO - PROCESS | 5459 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 23:56:45 INFO - PROCESS | 5459 | Values: 64.0 64.0 62.0 63.0 62.0 63.0 63.0 63.0 62.0 62.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 23:56:45 INFO - PROCESS | 5459 | Values: 64.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 63.0 67.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:1.64 (2.1%) stddev-sans-first:1.62 23:56:45 INFO - PROCESS | 5459 | Values: 81.0 78.0 79.0 78.0 80.0 79.0 83.0 79.0 78.0 78.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:131.00 stddev:19.28 (14.7%) stddev-sans-first:20.44 23:56:45 INFO - PROCESS | 5459 | Values: 139.0 130.0 128.0 131.0 132.0 129.0 131.0 131.0 191.0 127.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.50 stddev:3.06 (1.8%) stddev-sans-first:3.19 23:56:45 INFO - PROCESS | 5459 | Values: 170.0 168.0 165.0 172.0 169.0 165.0 165.0 166.0 171.0 173.0 23:56:45 INFO - PROCESS | 5459 | 23:56:45 INFO - PROCESS | 5459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 23:56:45 INFO - PROCESS | 5459 | Values: 68.0 66.0 70.0 68.0 66.0 66.0 67.0 65.0 67.0 66.0 23:56:45 INFO - PROCESS | 5459 | -------- Summary: end -------- 23:56:45 INFO - PROCESS | 5459 | 23:56:46 INFO - TEST-INFO | 5459: exit 0 23:56:46 INFO - TEST-OK | kraken | took 64109ms 23:56:46 INFO - SUITE-END | took 1184s 23:56:46 INFO - Completed test suite (00:19:44) 23:56:46 INFO - javascript benchmark 23:56:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.4088059746255, 2573.613957906315, 2606.37447012717, 2614.529384710752, 2618.4239467317198, 4580.152671755719, 4630.907381852365, 4634.745089020107, 4639.443266807979, 4690.624750019999, 4657.767111644413, 4694.037722266936, 4735.73953432561, 4745.667803253774, 4769.022350418165, 4278.208531421689, 4286.549912259215, 4322.28682267427, 4362.214801335758, 4366.825326986933, 4375.540568240337, 4414.801333939964, 4447.555244475543, 4461.219286624844, 4469.994251293466, 4231.597998190167, 4297.376880352363, 4302.763348015857, 4363.890902727426, 4390.407295015164, 4327.891802704926, 4344.261475549132, 4350.782460876975, 4352.260115780325, 4352.521222665504, 4282.50751163617, 4320.913581728348, 4321.0709697415205, 4331.675124365685, 4371.650267978586, 4573.611243044345, 4596.609288210473, 4620.792064357079, 4707.8587642370785, 4796.952030479685, 4948.455669876311, 4986.10250154972, 4986.551210391046, 4988.65079444439, 4992.126377883892, 4900.0, 4972.105021096201, 5019.19692849146, 5019.397672279313, 5026.396832380138, 4666.136764698542, 4671.392718946515, 4672.836450724209, 4714.434267887876, 4715.339852420664, 5138.126518491866, 5141.897162056813, 5173.482651734872, 5174.456682048406, 5175.560077393464, 4768.141734487756, 4893.681910675795, 4948.802047918043, 4952.752362381866, 4953.578945789576, 5024.120778863684, 5051.696898186121, 5085.084684756705, 5091.490850914953, 5091.770870310845, 4978.1288274552535, 4986.252062190701, 4989.725565093955, 4998.750062496861, 5049.772760225798, 4817.349657796222, 4906.58294045003, 4965.90068198634, 4973.1297023020825, 4977.32806071183, 4191.0, 4195.412642230091, 4197.139586384784, 4208.116295577902, 4244.384564238168, 3649.7445178837756, 3687.3547129252274, 3706.4069748840056, 3710.424884142962, 3719.9442008369897, 4240.639545638655, 4270.466191726035, 4314.288142456459, 4323.2434323993175, 4330.112326972963, 5024.070546948826, 5032.84901452957, 5038.521340472649, 5039.571636410873, 5070.340855688737, 4219.873403797891, 4312.805923733376, 4324.243257429937, 4325.329573916048, 4367.694261401735, 4430.8449204277695, 4447.2439685253585, 4477.731336119843, 4480.641548676163, 4485.102979404132, 4664.3469914211355, 4669.252919532994, 4671.15919134559, 4689.695169814019, 4715.740634265148, 4900.215965445655, 4925.704457732548, 4991.5258050485145, 4993.625478089085, 4996.925046124384, 4632.397788287636, 4664.836730714409, 4677.391939047902, 4695.36612557314, 4727.645426593088, 4942.8022879085875, 4953.108440480748, 4960.0, 4963.354763880672, 4996.275540046746, 4853.150698627655, 4938.530839570235, 4976.651634385558, 5032.0690672225755, 5060.595152387874, 4866.221404575251, 4870.1964175912, 4891.413030436228, 4914.508549145057, 4924.704517728947, 4869.293952376956, 4877.0, 4878.048780487913, 4886.389201349832, 4928.67963582366, 4661.230896901973, 4751.6436267279405, 4804.039192161652, 4884.0, 4890.364252647133, 4967.230079337708, 4967.7019378837385, 4979.053979743837, 4989.25161225819, 5027.974860125676, 4855.150348689036, 4869.0, 4870.147724148331, 4873.585745211697, 4926.827561035347], "value": 4598.540471107973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4247131632709, 573.7848306884918, 581.0006788324081, 585.4233579923774, 585.4964730331914, 40920.38619420707, 42546.787266063664, 42699.0, 45946.0, 46106.769466152626, 43756.0, 44202.11595768083, 44206.77896610512, 44265.55734442655, 44292.0, 7557.244275572454, 7943.768715849038, 8083.595820208995, 8089.595520223966, 10087.04173103554, 10048.598056077784, 10385.376877387343, 10386.844197337046, 10393.53229104692, 10398.168146548258, 10420.905804890492, 10450.268481206318, 10467.31962422444, 10475.109615682675, 10477.109445697086, 7662.157162712125, 10081.092701656813, 10329.276950613461, 10335.94832025835, 10379.377237365745, 10247.897521024768, 10306.484675766256, 10310.587576496931, 10318.1745460363, 10324.380537167794, 40161.79919100415, 40470.0, 40510.0, 40541.0, 40551.797241013905, 2610.830296030752, 2760.6963234044238, 3046.086174147769, 3278.409886220479, 3451.8274086295582, 29853.701462985526, 30243.0927072186, 30288.54567181494, 30461.23846903823, 30796.076117716504, 3270.2641905571295, 3443.276911848515, 3450.102973226954, 3456.8962931112105, 3502.544669193014, 256501.0, 256559.0, 257091.0, 257954.0, 258810.9999999981, 48809.75595122073, 50030.74984625054, 50282.74858625756, 50292.74853625709, 55615.72192139013, 54545.0, 58105.70947145322, 58182.7090864543, 58220.417795822344, 58236.0, 14497.782533262009, 14498.710025799635, 14586.051906626035, 14598.854011459749, 14602.48891288821, 10290.3825770454, 10455.94772026135, 10460.68617941463, 10577.629782957714, 10581.947090264654, 17391.0, 17749.911250443663, 17791.19939602721, 17853.910730446525, 17857.821421785615, 5788.3343415506915, 5870.3249126350165, 5933.762649494059, 5944.5838791284195, 5960.910586341209, 700.1248439450686, 788.8225149341353, 796.7689370082727, 832.5337810825957, 910.1035480052143, 25955.221343359728, 26946.595801063, 27166.456670866868, 27671.58492622612, 27879.721202788118, 818.1532114261711, 826.3595713322223, 864.9351298652626, 904.9954750226207, 929.3958926697566, 13749.31253437324, 14045.0, 14284.57146285613, 14418.06080230264, 14498.782518262235, 377775.0, 383812.0, 384036.0, 384533.0, 384590.0, 50710.492895071315, 50967.0, 51067.489325106275, 51103.48896510987, 51134.74432627813, 1067.7330667333167, 1095.085603521037, 1107.0977153619936, 1185.8102703567388, 1208.8938621161715, 23927.76072239325, 29676.0, 29685.40629187361, 31693.841530792197, 32996.1750956228, 49023.754881225366, 49592.504074958786, 49691.254631179836, 49766.50233497618, 49902.750486247336, 355669.0, 361734.0, 362106.0, 362795.0, 363624.0, 28894.566581501716, 31877.840610797724, 34680.65319346875, 34824.12939676528, 37791.0, 41164.794176028925, 41188.38217426681, 41473.1705365897, 42392.788036059625, 42589.787051064544, 35393.82303088468, 35825.82087089548, 36028.279434410644, 36245.63754362422, 36290.455643164845, 35556.0, 35819.82090089533, 35880.820595897894, 35975.820120899225, 36030.279394412486, 34484.82757586196, 35553.0, 35764.0, 35894.0, 35913.46129808003, 30608.540871886493, 31806.863163325328, 31979.0, 32028.359432811678, 32356.191095222806, 24530.14144504934, 24619.13833015836, 24638.13766518163, 24750.876245618656, 25203.369915752253], "value": 18238.720324170037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9302832461832, 367.81057755256046, 368.8727389050777, 377.11566376846287, 379.2453018493198, 16424.260908259126, 17333.39333123341, 18164.727529087075, 18182.454526364196, 18188.999605021734, 16519.91740041298, 17135.485935421926, 17263.39578114766, 17873.19570619322, 17913.104344782772, 4652.1858674731875, 4817.470078291385, 4829.710217386951, 4856.101621200071, 4856.247281671329, 3542.2738338640515, 3669.156094098359, 4757.310190022445, 6024.0, 6327.8418039548915, 6309.3375195604485, 6351.015592583134, 6391.105245265667, 6392.680365981706, 6394.616323020634, 5673.602847800656, 5762.567807414461, 5769.0, 5770.971145144289, 5775.249217601727, 3413.84637691302, 4987.975060124712, 5287.68273903567, 5294.973525132388, 5573.554115670777, 11135.05352045077, 11137.443127843575, 11176.497057632427, 11228.887711122947, 11963.760724785456, 1896.6111947050958, 1900.9049547522707, 1923.778765441978, 1923.8653294269407, 2028.1177687705895, 9316.534173291377, 9376.390534615228, 9395.577199025993, 9783.217342612645, 9873.0, 1702.702027145257, 1758.753774471575, 1792.8744987850855, 1828.6122281005323, 1832.6426346862368, 39745.60254397448, 40110.19779604421, 40218.0, 40349.193016139805, 59661.403385966456, 9576.329656924088, 9791.951040244754, 9916.702498925044, 10217.489125543842, 10408.063274305348, 13493.190408575518, 13567.59297221085, 13585.45658173662, 13617.931910340385, 13719.725605488034, 7114.324139206767, 7115.075040244838, 7178.066851309401, 7244.239354867768, 7330.193678695339, 6523.380278873499, 6650.53446258767, 6791.0, 6961.477889158334, 7147.749828755968, 3922.980025193413, 4221.409002739619, 4295.098029413795, 4359.455068116486, 4361.978190109093, 1569.1918661889135, 1666.31681010785, 1728.08411541883, 1795.371619933013, 1821.317006122704, 756.6292516666794, 817.2930415190817, 845.7970087179033, 913.4245425381966, 935.2190920581255, 16795.83204167967, 17543.73684394735, 17564.91217543904, 17718.025508596893, 18073.909630452028, 830.2278880641062, 837.8533756592572, 840.3865178419787, 851.9531425771642, 930.418488444722, 9696.321257511907, 10004.399736015717, 10022.599096036078, 10097.141742951784, 10210.948945255375, 394263.0, 397221.0, 398273.0, 402569.0, 402680.0, 55708.44291557113, 81168.59415702884, 81595.11040536915, 81837.0, 81910.59044704738, 862.1895418306772, 874.9737507874773, 891.1667590802491, 894.3515950935649, 895.54327293081, 15425.479196812907, 15602.375904964128, 15818.288177032291, 15883.761743573625, 16236.51290461288, 37148.07129821668, 37225.627743722216, 37735.0, 38752.41871371988, 39247.0, 49743.75128124336, 52093.21860172025, 53360.46639533555, 54344.0, 54421.45578544164, 5344.9732751336, 7463.141738700119, 7739.374731306489, 7795.0, 8096.757097287091, 10200.59197632116, 12205.0, 12223.877761222275, 12229.510819567118, 12266.080043996915, 10231.079202871777, 10317.690469285933, 10819.945900270448, 10915.34507929495, 11155.27490713101, 9389.10803473669, 9897.901020989699, 10146.137578305927, 10621.681349559525, 10723.94638026805, 10342.224333175192, 10449.634262800766, 10467.267291289536, 10496.422696751752, 11170.0, 7996.84006319882, 8011.319037881845, 8050.677972881019, 8065.596720163851, 8267.751967440987, 9649.565769540248, 10344.741381465523, 10364.735108441118, 10433.739156520844, 10675.306105103144], "value": 8014.1796746933505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.862313768623, 1412.0186470403069, 1464.223961300511, 1672.6905522478341, 1682.1084825042717, 7631.313181813635, 8052.315553177987, 8154.633041513124, 8155.266026057654, 8162.673493060278, 6522.70647820848, 6702.296258892819, 6710.027046078316, 6844.555103918255, 7929.484583502069, 2130.648443006902, 2221.0782525252002, 2227.0646328542052, 2231.9218827341047, 2235.854669446489, 2226.565819665166, 2228.7771222877745, 2237.015713086245, 2259.5029093599464, 2261.0955617752948, 1877.9530511737248, 2163.491579478821, 2217.3347995601334, 2240.047979608668, 2243.3942835434423, 2184.1045171479695, 2212.281008672172, 2215.700880381144, 2215.7119574455296, 2216.4015715756655, 2151.354593621907, 2160.7731188225166, 2171.283476452767, 2186.1146235774536, 2189.0, 7714.0, 7810.843783124363, 7819.609019549, 7826.1391246962785, 7836.138024817265, 4491.39366185564, 4602.769861506911, 4611.608013318872, 4637.559431853969, 4646.697964632322, 2853.1155341844096, 2917.547780094089, 2955.3202763364548, 2955.5566665000206, 2964.6887076856833, 888.9866652000226, 889.4796544021755, 915.3501014279802, 916.6104405627648, 919.14978644754, 10987.890121098766, 10999.34003959757, 11000.22998390113, 11006.559737610485, 11008.559657613685, 4194.727342722713, 4242.469691288589, 4383.473983122046, 4385.978070109629, 4390.429244198233, 9409.059094090537, 9421.434713917188, 9423.811523769486, 9427.858582121273, 9429.245660347156, 4579.358889755437, 4583.747893865802, 4585.70192937458, 4588.082383523309, 4593.173228818778, 3510.78935263885, 4159.417681524589, 4165.604267594574, 4166.166766646622, 4166.416701661769, 3564.0, 3724.2365315110337, 3738.476613274144, 3742.120601658608, 3800.8289626966853, 1160.048760016778, 1161.73280145567, 1183.7040739815047, 1187.9465424055938, 1193.4868006757179, 703.5286358140058, 791.0388877513848, 825.6903661127077, 825.8059356051323, 849.1593322610571, 5241.50205730455, 5395.0, 5423.267858839085, 5450.945490545044, 5550.8057217997175, 816.1145157504175, 865.6018231613402, 871.5642178910545, 890.7995700967231, 901.9278457723366, 3570.4822800693755, 3686.5207523022373, 3700.907477313035, 3722.2927643747603, 3722.4230244312175, 9459.24326053914, 9734.41593504392, 9957.900420995697, 9970.950145249228, 9972.451515166591, 9261.16649501548, 9709.805803883883, 9715.70852874415, 10000.14998725102, 10006.849897251546, 7291.963540182265, 7363.300486453778, 7515.135759387631, 7543.9622801886735, 7555.584442855696, 5242.135047717084, 5280.471952804689, 5386.192071189353, 5458.0, 5460.31746031746, 8697.304215662858, 8949.507777072324, 8957.641694332415, 8973.32700047486, 8979.326550508607, 8923.15230053144, 8928.500614664772, 8965.865512017195, 9047.321450891079, 9123.635054597742, 6327.746890124527, 6568.343165683394, 6929.3070692930305, 7048.224695283412, 7115.217326094229, 7232.566046037255, 7256.818579535554, 7317.158526769277, 7317.414606831334, 7342.559446433231, 6435.32429094957, 6681.33186681328, 6683.532152749261, 6710.597364158166, 6735.461163106842, 6583.736650533925, 6635.834104147242, 6752.561083529555, 6756.864862702817, 6779.423748981392, 6390.808275751735, 6402.263739669997, 6441.323661015714, 6445.1943507061615, 6450.967745161244, 4261.957380426156, 4468.687191896536, 4497.730136191839, 4515.90968180628, 4535.637149028136, 4493.662975276802, 4528.252838281646, 4583.472900616472, 4590.127875703739, 4603.953960460352], "value": 4153.5735809579255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.0627401533992, 290.85602626699784, 294.8525737131434, 294.92037149969525, 295.9260184953762, 4861.0, 4915.803367865281, 4920.286558449023, 4927.950720492794, 4933.654644174909, 4818.783154758035, 4827.106985207739, 4831.710097394159, 4891.559759621633, 4894.702903730515, 3572.535570375854, 3651.598324184338, 3668.816559172031, 3804.182100848317, 3833.7508061976023, 3772.226693527834, 3790.867319643813, 3792.374258247386, 3799.6580307772297, 3841.78870162141, 3573.589037260709, 3743.88768336949, 3753.155540003491, 3772.9622703772884, 3787.9810600946957, 3642.708583313342, 3734.477173195755, 3777.8866634001024, 3781.3949768037255, 3784.8864534064023, 3314.3371325734947, 3326.2183386904057, 3326.6673332666783, 3340.5490258814993, 3350.1959529712935, 4794.232922732381, 4798.760061996921, 4800.759962001921, 4801.903961920777, 4814.422269327703, 4228.957710422918, 4301.311790113598, 4311.1808756336195, 4330.177266319421, 4331.6534677225745, 4964.578010869081, 4991.675541089818, 5045.117104506697, 5061.873453163664, 5078.619103567247, 3588.1926566522584, 3604.9725828138853, 3606.350856845767, 3613.313470440608, 3616.7341430499378, 5207.739613019372, 5213.947860521384, 5280.683159010472, 5348.491893270172, 5353.116735738598, 3644.890653280406, 3659.505966694462, 3666.2667466506273, 3669.633036696309, 3694.4827724118645, 3701.3522633539023, 3739.8504059837846, 3747.0, 3748.775073495599, 3759.721694623841, 4258.53156152823, 4276.828926842892, 4284.8500302489265, 4292.463442069741, 4297.140571885635, 4937.902438051905, 5003.174476211457, 5041.495850414929, 5044.344235249468, 5047.772850221675, 1268.2327192048863, 1279.8912092472244, 1285.4279845468864, 1285.736424033071, 1294.6116165150418, 841.1924552429736, 841.7432683031734, 872.1235158665501, 895.1183084661603, 900.8648702694649, 4412.4043254160915, 4412.624926881187, 4444.799984000728, 4491.169133710274, 4500.819967201275, 5072.442031376546, 5089.389273287229, 5158.509941555546, 5193.402758682724, 5200.167973124282, 4241.97879010603, 4413.845515406945, 4418.536053714378, 4427.601515863587, 4461.754603496839, 2735.411886444384, 2738.288045108286, 2746.4507098580366, 2753.435545713124, 2759.5374451540315, 4814.350062741555, 4816.8554943351755, 4831.903361932812, 4832.057748739033, 4844.32179494871, 5117.0, 5229.111051121318, 5267.736613169326, 5302.761375738101, 5305.681659100389, 4798.704349825458, 4820.975190420032, 4825.95174048262, 4834.975825120852, 4843.754684361556, 5102.4897510248675, 5132.666376685504, 5132.871678208075, 5147.871303217449, 5175.870603234949, 4888.800039981951, 5062.974685126551, 5064.341635587498, 5185.222216667379, 5192.896142077213, 4915.827946022016, 4919.065377578248, 4922.729249891147, 4926.8768280793265, 4933.851984440473, 3649.6897763690386, 3678.4114541673202, 3679.356112680324, 3682.834272457799, 3703.333399988028, 5153.866149447265, 5313.229581710708, 5351.705656188947, 5352.304200453916, 5353.759080841293, 5071.0, 5102.3722782767645, 5117.437081920912, 5124.79500819978, 5133.307003554472, 5116.334876466036, 5119.360079990001, 5120.18077107661, 5121.974390128025, 5123.077845987758, 4915.557599816034, 5052.368453943257, 5054.1155297822, 5056.356684077616, 5074.898502029865, 4935.383077115361, 4959.652824302264, 5121.487851214998, 5128.743562821918, 5139.152039913372, 5013.674111182761, 5020.648554601143, 5028.321176641107, 5056.064628043824, 5065.518775716301], "value": 3813.3084023044403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5617989317532, 661.9867602647951, 687.1959807025783, 695.9930400695991, 706.9752558660448, 12210.267383956969, 12835.935820320885, 12839.871601283985, 12844.165129266603, 12855.292958887258, 12850.164739291962, 13056.477740890377, 13074.73850522989, 13121.14712543684, 13130.474781008772, 620.664840985867, 773.1804287455316, 774.5043172369687, 794.7695168401157, 798.4690181029608, 786.626352482569, 794.7297918707638, 797.131127071492, 797.4457751862458, 797.5214871077366, 835.9498430094184, 837.8659414493683, 837.9958100209491, 838.6310023589632, 842.8988521377444, 657.8782925158837, 671.2783757460701, 673.7002034094829, 675.9256481786999, 841.6969890839293, 590.6898878088995, 602.7528713227599, 606.3542327421283, 609.7500024989733, 610.6854969690613, 13562.321883905865, 13564.525241616595, 13591.592252232449, 13600.115992460558, 13614.18314901109, 11911.344876031815, 12096.213746106563, 12506.562270320495, 12536.623901282976, 12727.363631818465, 11407.712746144853, 11545.13411494133, 11818.17272790905, 11909.344986025764, 12301.938490307492, 4085.428040074392, 4100.5899410059055, 4143.91712165755, 4282.50751163617, 4286.507051689065, 60079.0, 60100.39899600992, 60563.69718151425, 60707.39292607106, 60950.39049609447, 9586.616535338508, 9603.423794572209, 9638.0, 9675.467849268358, 9872.555734991798, 18409.447716568524, 18436.907815460836, 18444.170012349477, 18454.630907381776, 18463.630727385378, 6557.278699343068, 6625.900611490832, 6642.43539299165, 6674.666266686743, 6869.931300687029, 3563.572371315459, 3587.856485740593, 3615.8011309378235, 3639.454081887738, 3694.51971243742, 2600.726923673025, 2684.1276585109918, 2690.8250963687296, 2691.3675286307703, 2692.9596056059177, 476.77829809138916, 481.30932112418793, 482.17547992931776, 499.8225629901405, 504.7249249159217, 533.5891363650045, 549.3901769036366, 556.7077284425709, 558.1655425139443, 568.3861429655962, 7317.304856038668, 7333.633318334062, 7398.556086634819, 7404.370628496638, 7573.053368328959, 461.4605972193286, 508.2630186229907, 530.2205757536416, 542.2760614579502, 553.7397423211085, 3393.8472768724973, 3579.069441945113, 3598.082488965297, 3647.507586475792, 3674.540682414698, 91264.5436772812, 95469.0, 95604.0, 97150.51424742972, 98651.50674246583, 84236.0, 84272.57863710642, 84484.57757711172, 85672.0, 85709.57145214234, 74040.0, 75321.62339188378, 75728.56307213948, 75743.62128189544, 76515.23484765193, 6341.904871427025, 6377.330380310001, 6543.214814222133, 6623.304553021863, 6798.524103312919, 42245.577544224165, 42956.57043429526, 43704.12591748211, 44212.55787442213, 45108.32337514874, 58549.0, 61528.384716152264, 62176.0, 62802.37197627965, 63353.68323158355, 9903.653372132228, 10035.24735644844, 10155.187584993035, 10168.949155254177, 10433.791324173626, 10499.47502624881, 10704.785904282027, 10706.785864282827, 10734.409607471664, 10830.49078314548, 7069.9646501767165, 9961.452120133463, 10104.747381315527, 10184.847227291448, 11003.504842281956, 11723.589674361356, 11845.0, 11962.461689223832, 12200.75598488043, 12973.610791676265, 10759.408232547285, 11086.168537359892, 11098.223124381217, 11357.204995650225, 11500.137489688139, 9823.383009985295, 10347.844240538381, 10741.033307002408, 10770.623028193975, 10890.673279801618, 9627.0, 10037.648682296085, 10780.137588993019, 10820.89179108199, 10877.0], "value": 6366.123967302156, "unit": "score"}], "name": "dromaeo_css", "value": 6385.387131530624, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 115.0, 112.0, 112.0, 113.0, 113.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 130.0, 168.0, 124.0, 127.0, 148.0, 122.0, 200.0, 121.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 164.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 123.0, 77.0, 77.0, 73.0, 75.0, 100.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 119.0, 85.0, 86.0, 87.0, 111.0, 85.0, 85.0, 122.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 67.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 79.0, 78.0, 80.0, 79.0, 83.0, 79.0, 78.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 128.0, 131.0, 132.0, 129.0, 131.0, 131.0, 191.0, 127.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 165.0, 172.0, 169.0, 165.0, 165.0, 166.0, 171.0, 173.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 68.0, 66.0, 66.0, 67.0, 65.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1529.9, "alertThreshold": 2.0}]} 23:56:47 INFO - Return code: 0 23:56:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:56:47 INFO - # TBPL SUCCESS # 23:56:47 INFO - Running post-action listener: _resource_record_post_action 23:56:47 INFO - ##### 23:56:47 INFO - ##### Finished run-tests step (success) 23:56:47 INFO - ##### 23:56:47 INFO - Running post-run listener: _resource_record_post_run 23:56:47 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535048192; Read time: 8; Write time: 995516 23:56:47 INFO - TinderboxPrint: CPU usage
13.0% 23:56:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:56:47 INFO - TinderboxPrint: I/O write bytes / time
535,048,192 / 995,516 23:56:47 INFO - TinderboxPrint: CPU idle
8,339.6 (87.0%) 23:56:47 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 23:56:47 INFO - TinderboxPrint: Swap in / out
0 / 0 23:56:47 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 246308864; Read time: 0; Write time: 574368 23:56:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288468992; Read time: 8; Write time: 421124 23:56:47 INFO - Running post-run listener: _upload_blobber_files 23:56:47 INFO - Blob upload gear active. 23:56:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:56:47 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 23:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:56:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:56:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:56:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:56:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:48 INFO - (blobuploader) - INFO - Done attempting. 23:56:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:56:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:52 INFO - (blobuploader) - INFO - Done attempting. 23:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:52 INFO - (blobuploader) - INFO - Done attempting. 23:56:52 INFO - (blobuploader) - INFO - Iteration through files over. 23:56:52 INFO - Return code: 0 23:56:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:56:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:56:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7e3bd9586457b0e6bd6bc2958ead213d4a994ae3de1df65e6b12cb31b8e849ed08d7c339dd62cd9c2ead59aa62234ef0239ef79c1fb70aaee056578be29a63d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d678c83059d63b5b79008765b5eceae553bc5de8c077853a6b6539c1046aa9f4b61315ed6b9196878ad695fc69cc4d0c85c9f6ca1edf8d3421a748ef24d3a0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad4c3907e1a3dab87313df375cf88fc27425c150644c64d4cd73fff39f456e3553f0f4ed6a4c698b40c38df1268d3d47af978c289f2f912b31c43b7cff915c78"} 23:56:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:56:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:56:52 INFO - Contents: 23:56:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7e3bd9586457b0e6bd6bc2958ead213d4a994ae3de1df65e6b12cb31b8e849ed08d7c339dd62cd9c2ead59aa62234ef0239ef79c1fb70aaee056578be29a63d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d678c83059d63b5b79008765b5eceae553bc5de8c077853a6b6539c1046aa9f4b61315ed6b9196878ad695fc69cc4d0c85c9f6ca1edf8d3421a748ef24d3a0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad4c3907e1a3dab87313df375cf88fc27425c150644c64d4cd73fff39f456e3553f0f4ed6a4c698b40c38df1268d3d47af978c289f2f912b31c43b7cff915c78"} 23:56:52 INFO - Running post-run listener: copy_logs_to_upload_dir 23:56:52 INFO - Copying logs to upload dir... 23:56:52 INFO - mkdir: /builds/slave/test/build/upload/logs 23:56:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.969716 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-08 23:56:52.911714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 23:56:52.915987) ========= 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=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7e3bd9586457b0e6bd6bc2958ead213d4a994ae3de1df65e6b12cb31b8e849ed08d7c339dd62cd9c2ead59aa62234ef0239ef79c1fb70aaee056578be29a63d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d678c83059d63b5b79008765b5eceae553bc5de8c077853a6b6539c1046aa9f4b61315ed6b9196878ad695fc69cc4d0c85c9f6ca1edf8d3421a748ef24d3a0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad4c3907e1a3dab87313df375cf88fc27425c150644c64d4cd73fff39f456e3553f0f4ed6a4c698b40c38df1268d3d47af978c289f2f912b31c43b7cff915c78"} build_url:https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/cpwMTlTGQsWJ98nkUe3csA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7e3bd9586457b0e6bd6bc2958ead213d4a994ae3de1df65e6b12cb31b8e849ed08d7c339dd62cd9c2ead59aa62234ef0239ef79c1fb70aaee056578be29a63d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d678c83059d63b5b79008765b5eceae553bc5de8c077853a6b6539c1046aa9f4b61315ed6b9196878ad695fc69cc4d0c85c9f6ca1edf8d3421a748ef24d3a0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad4c3907e1a3dab87313df375cf88fc27425c150644c64d4cd73fff39f456e3553f0f4ed6a4c698b40c38df1268d3d47af978c289f2f912b31c43b7cff915c78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 23:56:52.943627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:56:52.944211) ========= 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=8783db0840cc980e80bb0bd400000236-1468042562.980616-35457132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:56:53.028428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 23:56:53.028759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 23:56:53.029067) ========= ========= Total master_lag: 0.40 =========