builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1468235752.47 results: success (0) buildid: 20160711024832 builduid: adfde23437bc4ea9866eda05deae5038 revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.470611) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.471104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.471392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.486447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.487021) ========= 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=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 04:15:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-11 04:15:54 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.577025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.577349) ========= 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=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.626427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:52.626815) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --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=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 04:15:54,183 truncating revision to first 12 chars 2016-07-11 04:15:54,183 Setting DEBUG logging. 2016-07-11 04:15:54,183 attempt 1/10 2016-07-11 04:15:54,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bee8d2da23e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 04:15:54,487 unpacking tar archive at: mozilla-central-1bee8d2da23e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:53.317150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:53.317466) ========= script_repo_revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:53.317897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:53.318174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:15:53.327733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 04:15:53.328009) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:54 INFO - MultiFileLogger online at 20160711 04:15:54 in /builds/slave/test 04:15:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:15:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:54 INFO - {'append_to_log': False, 04:15:54 INFO - 'base_work_dir': '/builds/slave/test', 04:15:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:15:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:54 INFO - 'branch': 'Firefox-Non-PGO', 04:15:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:54 INFO - 'config_files': ('talos/linux_config.py',), 04:15:54 INFO - 'default_actions': ('clobber', 04:15:54 INFO - 'read-buildbot-config', 04:15:54 INFO - 'download-and-extract', 04:15:54 INFO - 'populate-webroot', 04:15:54 INFO - 'create-virtualenv', 04:15:54 INFO - 'install', 04:15:54 INFO - 'run-tests'), 04:15:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:54 INFO - 'download_minidump_stackwalk': True, 04:15:54 INFO - 'download_symbols': 'ondemand', 04:15:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:54 INFO - 'installer_path': 'installer.exe', 04:15:54 INFO - 'log_level': 'info', 04:15:54 INFO - 'log_name': 'talos', 04:15:54 INFO - 'log_to_console': True, 04:15:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:54 INFO - 'opt_config_files': (), 04:15:54 INFO - 'pip_index': False, 04:15:54 INFO - 'sps_profile': False, 04:15:54 INFO - 'sps_profile_interval': 0, 04:15:54 INFO - 'suite': 'dromaeojs', 04:15:54 INFO - 'system_bits': '32', 04:15:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:54 INFO - 'title': 'talos-linux64-ix-056', 04:15:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:54 INFO - 'use_talos_json': True, 04:15:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:54 INFO - 'work_dir': 'build'} 04:15:54 INFO - ##### 04:15:54 INFO - ##### Running clobber step. 04:15:54 INFO - ##### 04:15:54 INFO - Running pre-action listener: _resource_record_pre_action 04:15:54 INFO - Running main action method: clobber 04:15:54 INFO - rmtree: /builds/slave/test/build 04:15:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:55 INFO - Running post-action listener: _resource_record_post_action 04:15:55 INFO - ##### 04:15:55 INFO - ##### Finished clobber step (success) 04:15:55 INFO - ##### 04:15:55 INFO - ##### 04:15:55 INFO - ##### Running read-buildbot-config step. 04:15:55 INFO - ##### 04:15:55 INFO - Running pre-action listener: _resource_record_pre_action 04:15:55 INFO - Running main action method: read_buildbot_config 04:15:55 INFO - Using buildbot properties: 04:15:55 INFO - { 04:15:55 INFO - "project": "", 04:15:55 INFO - "product": "firefox", 04:15:55 INFO - "script_repo_revision": "production", 04:15:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:15:55 INFO - "repository": "", 04:15:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:15:55 INFO - "buildid": "20160711024832", 04:15:55 INFO - "pgo_build": "False", 04:15:55 INFO - "basedir": "/builds/slave/test", 04:15:55 INFO - "buildnumber": 142, 04:15:55 INFO - "slavename": "talos-linux64-ix-056", 04:15:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:15:55 INFO - "platform": "ubuntu64_hw", 04:15:55 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:15:55 INFO - "branch": "mozilla-central", 04:15:55 INFO - "repo_path": "mozilla-central", 04:15:55 INFO - "revision": "1bee8d2da23ec894980fb14f516210fd83e5b9f9", 04:15:55 INFO - "stage_platform": "linux64", 04:15:55 INFO - "builduid": "adfde23437bc4ea9866eda05deae5038", 04:15:55 INFO - "slavebuilddir": "test" 04:15:55 INFO - } 04:15:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:15:55 INFO - Running post-action listener: _resource_record_post_action 04:15:55 INFO - ##### 04:15:55 INFO - ##### Finished read-buildbot-config step (success) 04:15:55 INFO - ##### 04:15:55 INFO - ##### 04:15:55 INFO - ##### Running download-and-extract step. 04:15:55 INFO - ##### 04:15:55 INFO - Running pre-action listener: _resource_record_pre_action 04:15:55 INFO - Running main action method: download_and_extract 04:15:55 INFO - mkdir: /builds/slave/test/build/tests 04:15:55 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')]} 04:15:55 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:15:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:15:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:15:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:15:57 INFO - Downloaded 1361 bytes. 04:15:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:15:57 INFO - Using the following test package requirements: 04:15:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:15:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'jsshell-linux-x86_64.zip'], 04:15:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:15:57 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:15:58 INFO - Downloaded 22735220 bytes. 04:15:58 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'] 04:15:58 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 04:15:59 INFO - Return code: 0 04:15:59 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 04:15:59 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')]} 04:15:59 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:16:00 INFO - Downloaded 22735220 bytes. 04:16:00 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'] 04:16:00 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 04:16:02 INFO - Return code: 0 04:16: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')]} 04:16:02 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:16:03 INFO - Downloaded 14403333 bytes. 04:16:03 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'] 04:16:03 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 04:16:03 INFO - Return code: 0 04:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:03 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:16:05 INFO - Downloaded 56656866 bytes. 04:16:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:05 INFO - mkdir: /builds/slave/test/properties 04:16:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:05 INFO - Contents: 04:16:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:05 INFO - Running post-action listener: _resource_record_post_action 04:16:05 INFO - Running post-action listener: set_extra_try_arguments 04:16:05 INFO - ##### 04:16:05 INFO - ##### Finished download-and-extract step (success) 04:16:05 INFO - ##### 04:16:05 INFO - ##### 04:16:05 INFO - ##### Running populate-webroot step. 04:16:05 INFO - ##### 04:16:05 INFO - Running pre-action listener: _resource_record_pre_action 04:16:05 INFO - Running main action method: populate_webroot 04:16:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:05 INFO - '--tppagecycles', 04:16:05 INFO - '7'], 04:16:05 INFO - 'tests': ['tsvgm']}}, 04:16:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['damp', 'tps']}, 04:16:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'tests': ['damp', 'tps']}, 04:16:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['dromaeo_dom']}, 04:16:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['basic_compositor_video']}, 04:16:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['a11yr', 04:16:05 INFO - 'ts_paint', 04:16:05 INFO - 'tpaint', 04:16:05 INFO - 'sessionrestore', 04:16:05 INFO - 'sessionrestore_no_auto_restore', 04:16:05 INFO - 'tabpaint']}, 04:16:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['tsvgx', 04:16:05 INFO - 'tsvgr_opacity', 04:16:05 INFO - 'tart', 04:16:05 INFO - 'tscrollx', 04:16:05 INFO - 'cart']}, 04:16:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:05 INFO - 'tsvgr_opacity', 04:16:05 INFO - 'tart', 04:16:05 INFO - 'tscrollx', 04:16:05 INFO - 'cart']}, 04:16:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'talos_options': ['--disable-e10s'], 04:16:05 INFO - 'tests': ['tp5o']}, 04:16:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'tests': ['tp5o']}, 04:16:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'talos_options': ['--disable-e10s', 04:16:05 INFO - '--xperf_path', 04:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:05 INFO - 'tests': ['tp5n']}, 04:16:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:05 INFO - 'talos_options': ['--xperf_path', 04:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:05 INFO - 'tests': ['tp5n']}}, 04:16:05 INFO - 'talos.zip': {'path': '', 04:16:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:05 INFO - Running post-action listener: _resource_record_post_action 04:16:05 INFO - ##### 04:16:05 INFO - ##### Finished populate-webroot step (success) 04:16:05 INFO - ##### 04:16:05 INFO - ##### 04:16:05 INFO - ##### Running create-virtualenv step. 04:16:05 INFO - ##### 04:16:05 INFO - Running pre-action listener: _resource_record_pre_action 04:16:05 INFO - Running main action method: create_virtualenv 04:16:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:16:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:06 INFO - Using real prefix '/usr' 04:16:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:08 INFO - Installing pip.................done. 04:16:08 INFO - Return code: 0 04:16:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:16:08 INFO - Using env: {'DISPLAY': ':0', 04:16:08 INFO - 'HOME': '/home/cltbld', 04:16:08 INFO - 'LANG': 'en_US.UTF-8', 04:16:08 INFO - 'LANGUAGE': 'en_US:en', 04:16:08 INFO - 'LOGNAME': 'cltbld', 04:16:08 INFO - 'MAIL': '/var/mail/cltbld', 04:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:08 INFO - 'MOZ_NO_REMOTE': '1', 04:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:08 INFO - 'NO_EM_RESTART': '1', 04:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:08 INFO - 'PWD': '/builds/slave/test', 04:16:08 INFO - 'SHELL': '/bin/bash', 04:16:08 INFO - 'SHLVL': '1', 04:16:08 INFO - 'TERM': 'linux', 04:16:08 INFO - 'TMOUT': '86400', 04:16:08 INFO - 'USER': 'cltbld', 04:16:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:08 INFO - '_': '/tools/buildbot/bin/python'} 04:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:16:08 INFO - Cleaning up... 04:16:08 INFO - Return code: 0 04:16:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:16:08 INFO - Using env: {'DISPLAY': ':0', 04:16:08 INFO - 'HOME': '/home/cltbld', 04:16:08 INFO - 'LANG': 'en_US.UTF-8', 04:16:08 INFO - 'LANGUAGE': 'en_US:en', 04:16:08 INFO - 'LOGNAME': 'cltbld', 04:16:08 INFO - 'MAIL': '/var/mail/cltbld', 04:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:08 INFO - 'MOZ_NO_REMOTE': '1', 04:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:08 INFO - 'NO_EM_RESTART': '1', 04:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:08 INFO - 'PWD': '/builds/slave/test', 04:16:08 INFO - 'SHELL': '/bin/bash', 04:16:08 INFO - 'SHLVL': '1', 04:16:08 INFO - 'TERM': 'linux', 04:16:08 INFO - 'TMOUT': '86400', 04:16:08 INFO - 'USER': 'cltbld', 04:16:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:08 INFO - '_': '/tools/buildbot/bin/python'} 04:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:08 INFO - Downloading/unpacking psutil>=3.1.1 04:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:10 INFO - Installing collected packages: psutil 04:16:10 INFO - Running setup.py install for psutil 04:16:11 INFO - building 'psutil._psutil_linux' extension 04:16:11 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 04:16:11 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 04:16:11 INFO - building 'psutil._psutil_posix' extension 04:16:11 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 04:16:11 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 04:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:11 INFO - Successfully installed psutil 04:16:11 INFO - Cleaning up... 04:16:11 INFO - Return code: 0 04:16:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:16:11 INFO - Using env: {'DISPLAY': ':0', 04:16:11 INFO - 'HOME': '/home/cltbld', 04:16:11 INFO - 'LANG': 'en_US.UTF-8', 04:16:11 INFO - 'LANGUAGE': 'en_US:en', 04:16:11 INFO - 'LOGNAME': 'cltbld', 04:16:11 INFO - 'MAIL': '/var/mail/cltbld', 04:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:11 INFO - 'MOZ_NO_REMOTE': '1', 04:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:11 INFO - 'NO_EM_RESTART': '1', 04:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:11 INFO - 'PWD': '/builds/slave/test', 04:16:11 INFO - 'SHELL': '/bin/bash', 04:16:11 INFO - 'SHLVL': '1', 04:16:11 INFO - 'TERM': 'linux', 04:16:11 INFO - 'TMOUT': '86400', 04:16:11 INFO - 'USER': 'cltbld', 04:16:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:11 INFO - '_': '/tools/buildbot/bin/python'} 04:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:16:13 INFO - Installing collected packages: mozsystemmonitor 04:16:13 INFO - Running setup.py install for mozsystemmonitor 04:16:13 INFO - Successfully installed mozsystemmonitor 04:16:13 INFO - Cleaning up... 04:16:13 INFO - Return code: 0 04:16:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:16:13 INFO - Using env: {'DISPLAY': ':0', 04:16:13 INFO - 'HOME': '/home/cltbld', 04:16:13 INFO - 'LANG': 'en_US.UTF-8', 04:16:13 INFO - 'LANGUAGE': 'en_US:en', 04:16:13 INFO - 'LOGNAME': 'cltbld', 04:16:13 INFO - 'MAIL': '/var/mail/cltbld', 04:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:13 INFO - 'MOZ_NO_REMOTE': '1', 04:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:13 INFO - 'NO_EM_RESTART': '1', 04:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:13 INFO - 'PWD': '/builds/slave/test', 04:16:13 INFO - 'SHELL': '/bin/bash', 04:16:13 INFO - 'SHLVL': '1', 04:16:13 INFO - 'TERM': 'linux', 04:16:13 INFO - 'TMOUT': '86400', 04:16:13 INFO - 'USER': 'cltbld', 04:16:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:13 INFO - '_': '/tools/buildbot/bin/python'} 04:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:16:14 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 04:16:14 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 04:16:14 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 04:16:14 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 04:16:14 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 04:16:14 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 04:16:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:16 INFO - warning: no files found matching '*.txt' 04:16:16 INFO - no previously-included directories found matching 'build' 04:16:16 INFO - no previously-included directories found matching 'dist' 04:16:16 INFO - no previously-included directories found matching '.git*' 04:16:16 INFO - Installing collected packages: jsonschema, functools32 04:16:16 INFO - Running setup.py install for functools32 04:16:16 INFO - warning: no files found matching '*.txt' 04:16:16 INFO - no previously-included directories found matching 'build' 04:16:16 INFO - no previously-included directories found matching 'dist' 04:16:16 INFO - no previously-included directories found matching '.git*' 04:16:16 INFO - Successfully installed jsonschema functools32 04:16:16 INFO - Cleaning up... 04:16:16 INFO - Return code: 0 04:16:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:16:16 INFO - Using env: {'DISPLAY': ':0', 04:16:16 INFO - 'HOME': '/home/cltbld', 04:16:16 INFO - 'LANG': 'en_US.UTF-8', 04:16:16 INFO - 'LANGUAGE': 'en_US:en', 04:16:16 INFO - 'LOGNAME': 'cltbld', 04:16:16 INFO - 'MAIL': '/var/mail/cltbld', 04:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:16 INFO - 'MOZ_NO_REMOTE': '1', 04:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:16 INFO - 'NO_EM_RESTART': '1', 04:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:16 INFO - 'PWD': '/builds/slave/test', 04:16:16 INFO - 'SHELL': '/bin/bash', 04:16:16 INFO - 'SHLVL': '1', 04:16:16 INFO - 'TERM': 'linux', 04:16:16 INFO - 'TMOUT': '86400', 04:16:16 INFO - 'USER': 'cltbld', 04:16:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:16 INFO - '_': '/tools/buildbot/bin/python'} 04:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:19 INFO - Downloading docopt-0.6.1.tar.gz 04:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:19 INFO - Running setup.py install for blobuploader 04:16:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:19 INFO - Running setup.py install for requests 04:16:19 INFO - Running setup.py install for docopt 04:16:19 INFO - Successfully installed blobuploader requests docopt 04:16:19 INFO - Cleaning up... 04:16:19 INFO - Return code: 0 04:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:20 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 04:16:20 INFO - Using env: {'DISPLAY': ':0', 04:16:20 INFO - 'HOME': '/home/cltbld', 04:16:20 INFO - 'LANG': 'en_US.UTF-8', 04:16:20 INFO - 'LANGUAGE': 'en_US:en', 04:16:20 INFO - 'LOGNAME': 'cltbld', 04:16:20 INFO - 'MAIL': '/var/mail/cltbld', 04:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:20 INFO - 'MOZ_NO_REMOTE': '1', 04:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:20 INFO - 'NO_EM_RESTART': '1', 04:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:20 INFO - 'PWD': '/builds/slave/test', 04:16:20 INFO - 'SHELL': '/bin/bash', 04:16:20 INFO - 'SHLVL': '1', 04:16:20 INFO - 'TERM': 'linux', 04:16:20 INFO - 'TMOUT': '86400', 04:16:20 INFO - 'USER': 'cltbld', 04:16:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:20 INFO - '_': '/tools/buildbot/bin/python'} 04:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:20 INFO - Running setup.py (path:/tmp/pip-pzJfFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:20 INFO - Running setup.py (path:/tmp/pip-hNkUo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:20 INFO - Running setup.py (path:/tmp/pip-HkRcp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:20 INFO - Running setup.py (path:/tmp/pip-ltsWpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:20 INFO - Running setup.py (path:/tmp/pip-gfKV2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:20 INFO - Running setup.py (path:/tmp/pip-A6A7rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:20 INFO - Running setup.py (path:/tmp/pip-JRcOLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:20 INFO - Running setup.py (path:/tmp/pip-4HKWuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:20 INFO - Running setup.py (path:/tmp/pip-nfwosA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:20 INFO - Running setup.py (path:/tmp/pip-GTm9qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:20 INFO - Running setup.py (path:/tmp/pip-1ymbgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:21 INFO - Running setup.py (path:/tmp/pip-DXaovW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:21 INFO - Running setup.py (path:/tmp/pip-Fgi_Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:21 INFO - Running setup.py (path:/tmp/pip-E304g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:21 INFO - Running setup.py (path:/tmp/pip-ikSoGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:21 INFO - Running setup.py (path:/tmp/pip-kPG6sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:21 INFO - Running setup.py (path:/tmp/pip-KF0Ysn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:21 INFO - Running setup.py install for manifestparser 04:16:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozcrash 04:16:21 INFO - Running setup.py install for mozdebug 04:16:21 INFO - Running setup.py install for mozdevice 04:16:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozfile 04:16:21 INFO - Running setup.py install for mozhttpd 04:16:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozinfo 04:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozInstall 04:16:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozleak 04:16:22 INFO - Running setup.py install for mozlog 04:16:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for moznetwork 04:16:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozprocess 04:16:22 INFO - Running setup.py install for mozprofile 04:16:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozrunner 04:16:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Running setup.py install for mozscreenshot 04:16:23 INFO - Running setup.py install for moztest 04:16:23 INFO - Running setup.py install for mozversion 04:16:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:23 INFO - Cleaning up... 04:16:23 INFO - Return code: 0 04:16:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:23 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')]} 04:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:23 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')]} 04:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:23 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:23 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 04:16:23 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 04:16:23 INFO - Using env: {'DISPLAY': ':0', 04:16:23 INFO - 'HOME': '/home/cltbld', 04:16:23 INFO - 'LANG': 'en_US.UTF-8', 04:16:23 INFO - 'LANGUAGE': 'en_US:en', 04:16:23 INFO - 'LOGNAME': 'cltbld', 04:16:23 INFO - 'MAIL': '/var/mail/cltbld', 04:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:23 INFO - 'MOZ_NO_REMOTE': '1', 04:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:23 INFO - 'NO_EM_RESTART': '1', 04:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:23 INFO - 'PWD': '/builds/slave/test', 04:16:23 INFO - 'SHELL': '/bin/bash', 04:16:23 INFO - 'SHLVL': '1', 04:16:23 INFO - 'TERM': 'linux', 04:16:23 INFO - 'TMOUT': '86400', 04:16:23 INFO - 'USER': 'cltbld', 04:16:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:23 INFO - '_': '/tools/buildbot/bin/python'} 04:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:23 INFO - Running setup.py (path:/tmp/pip-cN8wpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:23 INFO - Running setup.py (path:/tmp/pip-KwQJ3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:23 INFO - Running setup.py (path:/tmp/pip-29f34n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:23 INFO - Running setup.py (path:/tmp/pip-Je00V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:23 INFO - Running setup.py (path:/tmp/pip-bJ4vNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:23 INFO - Running setup.py (path:/tmp/pip-YApqGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:23 INFO - Running setup.py (path:/tmp/pip-1u2g1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:24 INFO - Running setup.py (path:/tmp/pip-nK5RhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:24 INFO - Running setup.py (path:/tmp/pip-b93doV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:24 INFO - Running setup.py (path:/tmp/pip-egF3Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:24 INFO - Running setup.py (path:/tmp/pip-jCYrT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:24 INFO - Running setup.py (path:/tmp/pip-xyAvBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:24 INFO - Running setup.py (path:/tmp/pip-h2HmFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:24 INFO - Running setup.py (path:/tmp/pip-Gh9lwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:24 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)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:24 INFO - Running setup.py (path:/tmp/pip-HOA_7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:24 INFO - Running setup.py (path:/tmp/pip-4VWvZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:24 INFO - Running setup.py (path:/tmp/pip-eYhHdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:26 INFO - Downloading blessings-1.6.tar.gz 04:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:26 INFO - Installing collected packages: blessings 04:16:26 INFO - Running setup.py install for blessings 04:16:26 INFO - Successfully installed blessings 04:16:26 INFO - Cleaning up... 04:16:26 INFO - Return code: 0 04:16:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:27 INFO - Reading from file tmpfile_stdout 04:16:27 INFO - Current package versions: 04:16:27 INFO - argparse == 1.2.1 04:16:27 INFO - blessings == 1.6 04:16:27 INFO - blobuploader == 1.2.4 04:16:27 INFO - docopt == 0.6.1 04:16:27 INFO - functools32 == 3.2.3-2 04:16:27 INFO - jsonschema == 2.5.1 04:16:27 INFO - manifestparser == 1.1 04:16:27 INFO - mozInstall == 1.12 04:16:27 INFO - mozcrash == 0.17 04:16:27 INFO - mozdebug == 0.1 04:16:27 INFO - mozdevice == 0.48 04:16:27 INFO - mozfile == 1.2 04:16:27 INFO - mozhttpd == 0.7 04:16:27 INFO - mozinfo == 0.9 04:16:27 INFO - mozleak == 0.1 04:16:27 INFO - mozlog == 3.2 04:16:27 INFO - moznetwork == 0.27 04:16:27 INFO - mozprocess == 0.23 04:16:27 INFO - mozprofile == 0.28 04:16:27 INFO - mozrunner == 6.12 04:16:27 INFO - mozscreenshot == 0.1 04:16:27 INFO - mozsystemmonitor == 0.3 04:16:27 INFO - moztest == 0.7 04:16:27 INFO - mozversion == 1.4 04:16:27 INFO - psutil == 3.1.1 04:16:27 INFO - requests == 1.2.3 04:16:27 INFO - wsgiref == 0.1.2 04:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:27 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 04:16:27 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 04:16:27 INFO - Using env: {'DISPLAY': ':0', 04:16:27 INFO - 'HOME': '/home/cltbld', 04:16:27 INFO - 'LANG': 'en_US.UTF-8', 04:16:27 INFO - 'LANGUAGE': 'en_US:en', 04:16:27 INFO - 'LOGNAME': 'cltbld', 04:16:27 INFO - 'MAIL': '/var/mail/cltbld', 04:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:27 INFO - 'MOZ_NO_REMOTE': '1', 04:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:27 INFO - 'NO_EM_RESTART': '1', 04:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:27 INFO - 'PWD': '/builds/slave/test', 04:16:27 INFO - 'SHELL': '/bin/bash', 04:16:27 INFO - 'SHLVL': '1', 04:16:27 INFO - 'TERM': 'linux', 04:16:27 INFO - 'TMOUT': '86400', 04:16:27 INFO - 'USER': 'cltbld', 04:16:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:27 INFO - '_': '/tools/buildbot/bin/python'} 04:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 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)) 04:16:27 INFO - Cleaning up... 04:16:27 INFO - Return code: 0 04:16:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 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 0xb7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, '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': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', '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 04:16:27 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 04:16:27 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 04:16:27 INFO - Using env: {'DISPLAY': ':0', 04:16:27 INFO - 'HOME': '/home/cltbld', 04:16:27 INFO - 'LANG': 'en_US.UTF-8', 04:16:27 INFO - 'LANGUAGE': 'en_US:en', 04:16:27 INFO - 'LOGNAME': 'cltbld', 04:16:27 INFO - 'MAIL': '/var/mail/cltbld', 04:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:27 INFO - 'MOZ_NO_REMOTE': '1', 04:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:27 INFO - 'NO_EM_RESTART': '1', 04:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:27 INFO - 'PWD': '/builds/slave/test', 04:16:27 INFO - 'SHELL': '/bin/bash', 04:16:27 INFO - 'SHLVL': '1', 04:16:27 INFO - 'TERM': 'linux', 04:16:27 INFO - 'TMOUT': '86400', 04:16:27 INFO - 'USER': 'cltbld', 04:16:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:27 INFO - '_': '/tools/buildbot/bin/python'} 04:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:16:27 INFO - Cleaning up... 04:16:27 INFO - Return code: 0 04:16:27 INFO - Running post-action listener: _resource_record_post_action 04:16:27 INFO - Running post-action listener: _start_resource_monitoring 04:16:27 INFO - Starting resource monitoring. 04:16:27 INFO - ##### 04:16:27 INFO - ##### Finished create-virtualenv step (success) 04:16:27 INFO - ##### 04:16:27 INFO - ##### 04:16:27 INFO - ##### Running install step. 04:16:27 INFO - ##### 04:16:27 INFO - Running pre-action listener: _resource_record_pre_action 04:16:27 INFO - Running main action method: install 04:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:27 INFO - Reading from file tmpfile_stdout 04:16:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:27 INFO - Reading from file tmpfile_stdout 04:16:27 INFO - Output received: 04:16:27 INFO - Usage: mozinstall [options] installer 04:16:27 INFO - Options: 04:16:27 INFO - -h, --help show this help message and exit 04:16:27 INFO - -d DEST, --destination=DEST 04:16:27 INFO - Directory to install application into. [default: 04:16:27 INFO - "/builds/slave/test"] 04:16:27 INFO - --app=APP Application being installed. [default: firefox] 04:16:27 INFO - mkdir: /builds/slave/test/build/application 04:16:27 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'] 04:16:27 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 04:16:44 INFO - Reading from file tmpfile_stdout 04:16:44 INFO - Output received: 04:16:44 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:44 INFO - Running post-action listener: _resource_record_post_action 04:16:44 INFO - ##### 04:16:44 INFO - ##### Finished install step (success) 04:16:44 INFO - ##### 04:16:44 INFO - ##### 04:16:44 INFO - ##### Running run-tests step. 04:16:44 INFO - ##### 04:16:44 INFO - Running pre-action listener: _resource_record_pre_action 04:16:44 INFO - Running main action method: run_tests 04:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:44 INFO - Python 2.7.3 04:16:44 INFO - Return code: 0 04:16:44 INFO - grabbing minidump binary from tooltool 04:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:16:44 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 0xe3e3b0>, '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 0xe3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:44 INFO - Return code: 0 04:16:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 04:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 04:16:44 INFO - Using env: {'DISPLAY': ':0', 04:16:44 INFO - 'HOME': '/home/cltbld', 04:16:44 INFO - 'LANG': 'en_US.UTF-8', 04:16:44 INFO - 'LANGUAGE': 'en_US:en', 04:16:44 INFO - 'LOGNAME': 'cltbld', 04:16:44 INFO - 'MAIL': '/var/mail/cltbld', 04:16:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:44 INFO - 'MOZ_NO_REMOTE': '1', 04:16:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:44 INFO - 'NO_EM_RESTART': '1', 04:16:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:44 INFO - 'PWD': '/builds/slave/test', 04:16:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:44 INFO - 'SHELL': '/bin/bash', 04:16:44 INFO - 'SHLVL': '1', 04:16:44 INFO - 'TERM': 'linux', 04:16:44 INFO - 'TMOUT': '86400', 04:16:44 INFO - 'USER': 'cltbld', 04:16:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198', 04:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:44 INFO - '_': '/tools/buildbot/bin/python'} 04:16:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 04:16:44 INFO - mozversion application_buildid: 20160711024832 04:16:44 INFO - mozversion application_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 04:16:44 INFO - mozversion application_display_name: Nightly 04:16:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:44 INFO - mozversion application_name: Firefox 04:16:44 INFO - mozversion application_remotingname: firefox 04:16:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:16:44 INFO - mozversion application_vendor: Mozilla 04:16:44 INFO - mozversion application_version: 50.0a1 04:16:44 INFO - mozversion platform_buildid: 20160711024832 04:16:44 INFO - mozversion platform_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 04:16:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:16:44 INFO - mozversion platform_version: 50.0a1 04:16:44 INFO - using testdate: 1468235804 04:16:44 INFO - actual date: 1468235804 04:16:44 INFO - starting webserver on 'localhost:39614' 04:16:44 INFO - SUITE-START | Running 2 tests 04:16:44 INFO - TEST-START | dromaeo_css 04:16:44 INFO - operating with platform_type : linux_ 04:16:44 INFO - Initialising browser for dromaeo_css test... 04:16:44 INFO - TEST-INFO | started process 17909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE_VqHf/profile http://localhost:39614/getInfo.html) 04:16:48 INFO - PROCESS | 17909 | __metrics Screen width/height:1600/1200 04:16:48 INFO - PROCESS | 17909 | colorDepth:24 04:16:48 INFO - PROCESS | 17909 | Browser inner width/height: 1024/697 04:16:48 INFO - PROCESS | 17909 | __metrics 04:16:49 INFO - PROCESS | 17909 | 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" 04:16:49 INFO - PROCESS | 17909 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:50 INFO - TEST-INFO | 17909: exit 0 04:16:50 INFO - Browser initialized. 04:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:50 INFO - TEST-INFO | started process 17993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE_VqHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:02 INFO - PROCESS | 17993 | RSS: Main: 159301632 04:17:02 INFO - PROCESS | 17993 | 04:17:54 INFO - PROCESS | 17993 | 1468235873998 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] 04:20:05 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39614/tests/dromaeo/cssquery-ext.html) 04:20:06 INFO - PROCESS | 17993 | RSS: Main: 239054848 04:20:06 INFO - PROCESS | 17993 | 04:23:09 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-ext.html (next: http://localhost:39614/tests/dromaeo/cssquery-jquery.html) 04:23:10 INFO - PROCESS | 17993 | RSS: Main: 245923840 04:23:10 INFO - PROCESS | 17993 | 04:26:12 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39614/tests/dromaeo/cssquery-mootools.html) 04:26:12 INFO - PROCESS | 17993 | RSS: Main: 246497280 04:26:12 INFO - PROCESS | 17993 | 04:29:15 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39614/tests/dromaeo/cssquery-prototype.html) 04:29:15 INFO - PROCESS | 17993 | RSS: Main: 242307072 04:29:15 INFO - PROCESS | 17993 | 04:32:18 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39614/tests/dromaeo/cssquery-yui.html) 04:32:19 INFO - PROCESS | 17993 | RSS: Main: 217579520 04:32:19 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-yui.html (next: http://localhost:39614/tests/dromaeo/cssquery-dojo.html) 04:35:22 INFO - PROCESS | 17993 | RSS: Main: 281583616 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | __start_tp_report 04:35:22 INFO - PROCESS | 17993 | _x_x_mozilla_page_load 04:35:22 INFO - PROCESS | 17993 | _x_x_mozilla_page_load_details 04:35:22 INFO - PROCESS | 17993 | |i|pagename|runs| 04:35:22 INFO - PROCESS | 17993 | |0;dojo.html;2531.164715643837;2558.705748838882;2603.6485074514935;2613.3858543242336;2615.189291319691;4558.407407037081;4624.09830083134;4669.206234940059;4700.717956922587;4727.243641017438;4660;4666.323383109447;4673.696209746364;4700;4706.082313948781;4264.59486348798;4288.592583704543;4337.414449049385;4349.69552131351;4364.7817609119575;34.41032515189334;4382.934255986147;4384.934225986613;4390.121975604876;4411.382406463082;4208.768517731523;4247.893802654959;4270.295401258789;4372.606465418112;4397.812590600536;4292.935605965882;4300.978495107535;4304.80628371724;4305.870823875289;4312.5903039211225;4275.551067137937;4281.614654681093;4296.570342965679;4307.719998200107;4330.783460826978;4701.200795864711;4747.905041899177;4751.596114330286;4752.572268495852;4752.809887604526;5073.746312684351;5080;5081.415637201732;5086.262491938648;5089.262057001751;4927.975360123212;4937.1606826839525;4975.701457912501;4988.975055124737;5076.111680455905;4694.293816228035;4761.2382018876815;4782.33047373368;4784.712917224942;4788.209945358977;5143.305653736697;5225.686458812484;5226;5235.267062611238;5237.711925844039;4747.287906813936;4854.781534830941;4908.01839632075;4982.153033984231;5007.499250075036;5021.447640759514;5064.392272927199;5064.392272927273;5069.493050694975;5074.441811400743;4981.37732783402;4990.875228119254;4993.725345106054;5018.4981501849525;5035.899282014339;4726.574608285271;4857.1742803723455;4901.019796040806;4921.680090794087;4955.132851750929;4196.538380778112;4200.201961627281;4209.515905670826;4210.200061988213;4222.577742225752;3672.338978983755;3674.026383008505;3677;3707;3718.2749363874327;4176.2900306947895;4195.622393984556;4224.809883555247;4289.9571004289555;4302.075053863435;5006.574441172541;5038.5969122470115;5040;5042.117629414911;5079.923801142986;4299.054208074282;4301.0537681709975;4306.612404883575;4339.500957389878;4350.086481838849;4378.605925466723;4403.867883963486;4472.127935052698;4498.640108791289;4501.572350626685;4642.16441040616;4653.883652908637;4660.836870709577;4674.6026587740425;4738;4993.226049962262;5028.497150284942;5031.345925029723;5047.621428392812;5081.949180508148;4522.457305123275;4555.362249285036;4577.107464044612;4611.976940115278;4697.342372067981;4752.19212733843;4769.356136921471;4774.641901857444;4785.617150628011;4809.879753006203;4990.900181996267;4997.525235102659;4999.550040496373;4999.925001125059;5051.141305978066;4606.539346065367;4643.674942753974;4660;4685.625149988061;4697.906041879211;4677.391939048038;4701.03628756111;4701.835435759732;4711.717296962193;4748.548887855648;4509.571590698878;4634.606058485067;4652.953085555723;4694.483606803181;4705.576498115049;4708.387909571734;4727.456342520654;4780.091782561302;4781.043791241835;4799.112164249625;4660.6970546914345;4683.601893838925;4683.8360657376825;4687.414073240845;4728.361671174347 04:35:22 INFO - PROCESS | 17993 | |1;ext.html;573.4638113364005;589.5224867857036;595.5295316699808;616.8211218746563;621.2700077409044;39040.414393784115;40772;40862.59137408629;43882;44178.33732494015;40621.59378406215;41354.7932260339;41656.79171604145;41706;41732;7264.200937896853;8019.759407217793;8154;8175.509469431853;10345.37927724339;10261.79476410475;10547;10559.208059395538;10603.204759643018;10613.257072004924;10568.577256909715;10611.522481488351;10618.946905265502;10621.522031508563;10624.256302058859;7662.463627546074;7853.842923141505;7859.135495095535;10165.339252948535;10445.68662940113;10097.646582369654;10438.425886576235;10463.058324750733;10466.319689220176;10472.476376181237;39349;39439.80280098581;39572.60427395718;39805.80097099496;39836.80081599573;2913.373624670706;2950.468915595192;3037.878484860603;3084.7532197424152;3200.983995080033;29979.850100749576;30164.24589385283;30655;30793.538096928565;31511;3003.1591154476564;3097.3340731742783;3305.6198537168293;3357.3285342931513;3387.745919056056;272253;272382;273744;274214;274298;55665.44334556683;56005.719971399885;56179;56179;56194.71902640461;33529.66470335314;34015;34289.14277143091;35963.460548091796;36261.63738362635;12546.1844980076;12574.87425125737;12648.430820613094;12663.303518306582;12683;8534.87197692035;9256.95371523138;9485.762855928657;9504.42973421597;9639.132478076866;18362.265509379744;18415.447536573924;18500;18586.907065464588;18700.81299186991;6565.146530950946;6835.521513494008;6875.449964002868;6927.203371612229;6950.3049695030095;774.4810976645548;872.7556284240422;882.8631562107884;889.3996552327283;924.8705181274627;27785.444291114065;28118.29704257369;28348.858255709;28515.429691406054;28651.57022644662;953.9570719317647;963.4700914496999;976.277554609598;1041.3231399590175;1070.475467021154;14874.851251487347;15273.694526109415;15276;15308.387664493519;15399.614034736704;402384;405648;405938;407350;408075;48780.26829597559;50213.74893125511;50267;50283.245751313756;50305.74847125741;1039.308859608352;1079.0935614083894;1085.0939465546198;1158.3918442817587;1178.9410529473491;24307.635385469584;31346.843265783526;31400;31501.8424907874;31736.682633173372;46504.7674761624;46899;46946;46955.53044469511;46984.53015469802;349614;352383;352715;353188;353788;25310.493790124463;25392.111276105246;26128.477430451665;26147.869260653573;27270.454590908466;41711.58288417077;41858.37212441877;42383;42401.36397953972;43112.78443607762;35770.56917723366;36545.45181822222;36815.44776828403;37107;37128.443073354465;36429.63570364368;36457.81771091127;36513.08717281983;36658.816705917365;36969.260614788094;35430.114247143;36344.27311453809;37326.44010339793;37403;39883;30687.693123069377;32936;33288.1677958053;33383.83308083444;33685.663143368256;22953.196638117584;24060.639090414006;24261.150859720532;24279.75720242775;24357.75642243555 04:35:22 INFO - PROCESS | 17993 | |2;jquery.html;339.5127991332437;359.49131978250773;362.73339095764624;365.26034779571376;380.43315459964646;13640.386182621782;13981.930090349559;14405.927970360146;17510.562235944075;17550.648987020253;16799.496015119534;17030.318787248525;17772.377966771164;17820.73268900964;17845.46463606094;4851.272309153629;4981.203007518798;4987.8254261100865;4991.875203119915;4996.5503104720565;3554.591222009476;5966.194563733906;6276.152719382893;6285.591436556632;6422.903656445157;5762.769489220426;5885.028970219909;6354.7775827846035;6385.425311721944;6392.23293204816;5720.742566584493;5739.225204597367;5759.539236861083;5777.191193232929;5786.710664466802;4733.408323959505;4998.925231075336;5027.220780778948;5545.77816887324;5557.027520183992;12600.243985360816;12637.115401921868;12690.682732931658;12837.358132093357;19655;1852.6757817381904;1931.3916116423281;1932.3623204342534;1941.7184508246366;2024.6052019856133;8895.764842390243;9515.143637072628;9538.427694338361;9598.95200523993;9814.75463113428;1627.9674406511922;1739.7129473636835;1754.8508376787988;1764.80587135415;1807.0874208524742;67112;70454;71679.64160179217;73001.6349918247;74661.62669186619;9835.852462213072;9836.704898853046;10188.388696678223;10312.690619281433;10480.895191048145;13987;14088.929555352157;14106.576802695936;14137.939654525951;14139.434422623186;6775.661216939134;6857.382835544725;6886.311368863174;6952.130983627047;7044.471664625174;6398.328175541501;6418.6797245176;6422.42198202164;6505.674716264168;6530.608163510205;4380.211561918885;4395.648348132142;4398.971876325719;4424.11517696462;4480.059187570581;1836.728588949723;1846.8060853610446;1850.4726153046317;1860.702287633999;1861.3392245752834;833;867.0159369116099;878.4246318661287;910.717677519971;913.1918252346721;16715.164241788105;16976.74534881978;17523.56191095233;17634.91182544079;17637.206325715375;854.4189950833369;858.8797568340437;865.8614621660504;900.2752784008935;904.2765787370209;9495.76260593477;9792.804143917225;9796.9020309796;9808.21534277256;9816.90105662831;357386;360184;362023;362044;363143.1328337068;47697.76151119292;53311;72436.63781681164;72647;78749;890.8485557455248;908.6229214875884;924.7179610218814;947.8862536495665;955.3264948211494;12025.699357516132;15353.232338383259;15376.154311512973;16370.099644519665;16606.418775342805;37963.43054854235;38452.42321365238;38986.4152037714;39576.604233958446;39966.80016599898;50415;50994;57890.13164802615;57916.71041644765;58571;6607.834804129743;7085.291470852873;7264.67308971087;7291.197968223597;7448.329650331496;10450.581976720847;12006.399680016139;12384.75230495403;12435;12817.1668841525;10544.209184311054;10749.14006879432;10791.568337266735;10801.541791857999;10934.726631834268;10343.43111128865;10579.841302380317;10611.681649550526;10626.787464250827;10779.299345542515;10697.572097116028;10735.785284294427;10788.190885683449;10836.133109351076;11036.503357348778;7089.397401220954;7157.141143062866;7176.461765367514;7383.667734951832;7435.182129965808;8379.70671026511;10447.216458765472;10578.947105264733;10665.786684266115;10846.891531084588 04:35:22 INFO - PROCESS | 17993 | |3;mootools.html;1206.167744256463;1212.4907538833688;1338.0232430325862;1369.8424681161669;1371.773657346538;7237.7104915803375;7595.50629209101;7701.114371847239;7709;7731.420143489233;6495.870082598345;6671.166104236971;6671.432928201109;6810.693518791654;7498.775036748906;1894.5358387195122;2107.6311645461983;2182.1053368119074;2198.5932602468515;2204.8677079375207;2147.871127732333;2171.0989939175224;2174.7825217478285;2180.062573093569;2203.55928814237;1875.8593105517073;2191.860232679006;2200.108955872866;2200.90095945682;2201.8678879267213;1846.547595839028;1852.6109517001378;2097.4651463876767;2150.064721846002;2158.719366482363;2120.151939224307;2122.724045874042;2124.915003399862;2126.0645316061036;2128.861623994451;7497.250274972459;7547.471676982614;7549.245075492462;7551.773446796605;7554.395648348119;4512.977435112836;4605.102005109005;4626.843289177706;4648.976755116203;4658.231391820345;2804.1307194769483;2864.3268831824503;2873.2385917731817;2876.5397536394075;2898.043645596948;900.8648702694583;929.8930622978377;944.6976967370445;945.2957546627738;959.2230293462318;10001.49992500372;10031.699049028468;10074.647387341482;10104.141148002429;10116.595336186543;4080.6531444827524;4151.667866570728;4311;4315.093830295673;4320.287152619845;8542.18849209324;8592.140785921358;8609.69866054685;8620.78448038804;8638.56807159652;4605.907881842344;4638.768061596974;4659.602119364177;4659.627229821606;4665.95334046662;4054.432379466877;4199.887029937069;4200.243956087934;4244.066305412866;4259.914801703949;3519.472079188091;3560.9821950890077;3608.0438683748825;3638.5451818522683;3654.14127679995;1142.5544037825255;1145.5360578965533;1156.2715489241723;1158.5423757615695;1161.692151579832;774.2257742257742;781.3397678961269;784.9764507064797;799.0371602219312;821.2403526737744;4910.165271903785;5005.099082165172;5179.8446046618665;5263.315768950012;5270.49930256625;400.6494317472212;886.7472770260445;890.6749036601594;926.0878035135386;947.9004704506066;3356.1360590313125;3496.1434448560267;3516.043380144177;3525.7003154732133;3545.2200515886466;8798.912010879809;9126.36115471924;9133.588988495534;9135.77160570991;9160.6793762218;8982.550872456351;9053.094690530894;9058.411203271766;9063.456192628464;9087.909120908838;7064.081669382947;7184.389326907271;7192.784216473514;7201.991721159042;7222.638868056576;4863.4650188479945;5103.362079740033;5150.278960945546;5273.156294992783;5387.488188622075;8231;8325.666973321;8342.374321925758;8380.664773408995;8422.957885210535;8279.254867061993;8321.54231517248;8437.578121093798;8447.873281900653;8650.870236946324;5912.61567998096;6397.712102955285;6540;6544.247411547733;6622.668866556556;7221.061262035902;7241.167265764505;7315.597642129521;7322.890156647548;7334.606424779275;6459.128017717736;6470.191226096738;6560.245571759308;6615.636140012345;6705.966470167618;6339.1125242467015;6379.681015949277;6409;6444.871102577828;6532.869342613216;6112.510999120149;6132.08018797184;6178.814635560941;6181.505479561534;6191.81424557264;4381.145676593033;4383.276759334674;4430.534793846599;4456.197884380713;4457.108578284421;4311.2455320318195;4326.372675962031;4342.457192850894;4465.330200469955;4475.30632751924 04:35:22 INFO - PROCESS | 17993 | |4;prototype.html;297.9925501862453;304.91919641295044;308.26325083051495;309.23155957445744;309.8714033676026;4921.753912304383;4945.9505404945985;4952.87617809554;4960.767654555451;4971.776270067847;4876.902461950768;4904.705717656943;4906.062105468347;4919.655624106314;4926.704397736138;3667.7615954962907;3763.303788799067;3803.3344164771192;3839.6736277416453;3842.346801043829;3796.4874741909903;3852.5376954765466;3869.284182426246;3885.0870045539277;3885.8251378687887;3814.179951310468;3819.4461803038544;3825.9808700956455;3835.654791068803;3850.9614903851025;3649.489071529988;3730.1047748540427;3834.69322454203;3858.3633700439395;3864.768113913146;3372.0389688938535;3375.3418083473734;3408.1479630092476;3424.195314101184;3432.5880894292595;4720.244760838249;4750.524947505256;4792.736399498026;4816.205326121186;4820.63845211607;4162.438070860426;4344.545331887473;4345.174416860787;4363.38912552243;4377.934330985037;5044.344235249394;5052.393712754456;5059.494050594948;5067.239914012891;5076.6192535559985;3689.8339574719203;3701.5002974598624;3713.7771733695795;3716.312482190803;3724.7392682512236;5140.7172605506685;5271.128749294022;5361.597880159004;5368.70472124033;5381.919271210935;3764.3036038333;3769.3780526212868;3784.356659367859;3793.6016718244186;3798.2783271178387;3855.9974406654474;3860.749051311656;3863.2273545291055;3866.845326186921;3870.3420418528917;4347.847825326162;4378.124375124988;4378.978105109454;4389.692721509464;4400.845970391021;4900.215965445512;5106.489351064938;5114.514121158484;5138.845834624967;5148.4851514848215;1291.1155858237137;1302.5411539076295;1303.8395827713343;1305.2038256663427;1310.0894878059848;835.3567752830287;838.9303637861775;849.7110982266059;871.877937088808;895.2569367425021;4439.711418757771;4456.930336719164;4459.777011149495;4461.219286624828;4463.129689710475;5180.222966555047;5202.687838729688;5230.63385563007;5248.6588371755715;5251.632385733038;4280.785960701953;4389.18800021997;4411.867643970686;4429.424174857248;4439.178751930903;2791.441711657636;2803.018943369804;2805.1584524642526;2813.198238502017;2820.562812764025;4924;4928.728919909439;4933.728644924564;4936.963237720119;4951.306817045616;5241.868953276198;5411.675299482044;5431.8098866539485;5435;5503.11950087992;4931.964287499665;4935.605151587864;4961.181405068195;4976.651634385558;4980.178270585386;5281.257185128975;5303.628745987744;5307.495787900143;5310.097283461898;5350.224217488365;4954;5196.298499702643;5236.188390799432;5246.527812496894;5257;4911.624745071385;4933.531314525115;4935.136351138464;4937.975310123426;4954.504549545017;3742.0083677824855;3753.793541355142;3768.566614839219;3770.359038963438;3773.8301776419576;5061.936993231463;5218.764366093046;5314.4951229633125;5324.334458192726;5330.573554115584;4899.289603007615;4906.460289368238;4909.140900342354;4909.705417674951;4931.753412329441;4902.7058376497525;4946.282788995503;4988.401391833003;4990.226514890198;4992.775325110451;4672.74299913508;4933.235348520985;4935.901281974412;4941.851744447672;4972.328735620645;4775.928361074656;4868.683535570177;4965.304857319906;4985.052839960396;4993.2510123480315;4835.8065677372515;4845.176320025675;4922.1632322505975;4927.359443272351;4931.964287499665 04:35:22 INFO - PROCESS | 17993 | |5;yui.html;621.5121129913018;652.9738810447583;696.7839969609419;698.4901022253755;722.1442590530226;12004.399780010997;12714.491420343198;12776;14672;15204;14871.7025659487;14908.105513669187;15000.849991500081;15015.47445839396;15021.549353519413;634.6319134901746;649.54207283865;783.4946459533597;785.3599316557016;802.5265093594778;804.1355542791493;806.6249194124731;811.3144392987916;813.5932033983008;815.5188438821094;854.3165467625905;856.6830272799042;856.9914300857005;857.0272740439584;857.395536147018;657.8519833037576;670.7618795327686;675.2302375292171;675.2740803636111;848.520585868982;591.7100620695871;604.1421181921681;604.2929772166576;605.1467430922378;607.7022259093056;12891.80662290057;12923.22460652364;12928.54750083752;12961.870381296161;12965.157264777854;11907.22603030809;12574.748505029847;12592.874071259263;12771.744565108738;12873.22760634365;11501.069222239803;11583.420828958519;11655.242409243372;11736.413179341083;11931.164818462712;3698.7410881238325;3743.494628225209;3762.4544441055896;3770.2082562661876;3804.847806087781;61787;63234.36765632331;63310.36689633091;63546.682266588374;63636;9705.17506011997;9812;9829.164521015793;9841.950790246003;10017.649382271731;17341.65316693684;17363.95816251029;17410.39063632767;17418.216180271917;17431.65136697259;6359.07793369968;6419.45434638061;6428.935710642927;6517.641529715911;6607.768728094494;3506.964930350715;3534;3584.1756396028536;3664.3953747631876;3690.612485689018;2609.1520255916903;2724.727527247299;2727.481778462086;2732.098407525512;2738.3564862257354;481.4295060353492;483.50199294726485;494.2956287290597;504.29902435614525;504.3116146460129;424.0839786062091;495.7595566150414;509.959203263738;534.3774502704306;549.4806859034773;7337.596432196174;7415.184329723834;7428.925710742931;7534.54792712439;7544;457.615602893571;475.60049558371134;501.79928028788777;503.59963828755497;504.634140248317;3434.690877821008;3543.450765131409;3600.243948770735;3633.4368172933237;3775.5846856845724;91142;91689;94613;97057;97250;80157;82974;84919;84921;85690.57154714187;71583.6420817903;75852.62073689706;76657.6167119172;77152.22847771451;78035.8294625581;7205.772580243842;7230.42156627479;7292.088488938883;7421.109466864011;8600.569971501525;32268;43518.56481435145;44285.557144428145;44456.22069130992;48092;65290.34709653033;68008.3199168002;68295.3170468289;68376;68539.3146068533;10685.305455145392;11052.060574851228;11274.759776424422;11530.481128349076;11541.307521548733;13655.590332290047;13708.93145534266;13763.105398149088;13978.720425591635;14342;11505.137114716263;11571.768564628828;11659.834016598612;11878.287302761863;12272.325022123869;11863.40682965831;11870.82193767077;12085.214461060003;12681.682957926125;12742.61772146837;12021.879781202426;12482.937585312015;12746.49014039428;12894.806577901527;13020.674483137997;9392.95303523478;9537.820154791218;9657.903420965982;10006.849897251692;10040.748981275234;8844.601992910206;9165.721480785416;9706.6117355305;9770.902290977;9831.262655300738 04:35:22 INFO - PROCESS | 17993 | __end_tp_report 04:35:22 INFO - PROCESS | 17993 | __start_cc_report 04:35:22 INFO - PROCESS | 17993 | _x_x_mozilla_cycle_collect,921 04:35:22 INFO - PROCESS | 17993 | __end_cc_report 04:35:22 INFO - PROCESS | 17993 | __startTimestamp1468236922610__endTimestamp 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | ------- Summary: start ------- 04:35:22 INFO - PROCESS | 17993 | Number of tests: 6 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#0] dojo.html Cycles:165 Average:4568.81 Median:4694.48 stddev:600.75 (12.8%) stddev-sans-first:580.94 04:35:22 INFO - PROCESS | 17993 | Values: 2531.2 2558.7 2603.6 2613.4 2615.2 4558.4 4624.1 4669.2 4700.7 4727.2 4660.0 4666.3 4673.7 4700.0 4706.1 4264.6 4288.6 4337.4 4349.7 4364.8 34.4 4382.9 4384.9 4390.1 4411.4 4208.8 4247.9 4270.3 4372.6 4397.8 4292.9 4301.0 4304.8 4305.9 4312.6 4275.6 4281.6 4296.6 4307.7 4330.8 4701.2 4747.9 4751.6 4752.6 4752.8 5073.7 5080.0 5081.4 5086.3 5089.3 4928.0 4937.2 4975.7 4989.0 5076.1 4694.3 4761.2 4782.3 4784.7 4788.2 5143.3 5225.7 5226.0 5235.3 5237.7 4747.3 4854.8 4908.0 4982.2 5007.5 5021.4 5064.4 5064.4 5069.5 5074.4 4981.4 4990.9 4993.7 5018.5 5035.9 4726.6 4857.2 4901.0 4921.7 4955.1 4196.5 4200.2 4209.5 4210.2 4222.6 3672.3 3674.0 3677.0 3707.0 3718.3 4176.3 4195.6 4224.8 4290.0 4302.1 5006.6 5038.6 5040.0 5042.1 5079.9 4299.1 4301.1 4306.6 4339.5 4350.1 4378.6 4403.9 4472.1 4498.6 4501.6 4642.2 4653.9 4660.8 4674.6 4738.0 4993.2 5028.5 5031.3 5047.6 5081.9 4522.5 4555.4 4577.1 4612.0 4697.3 4752.2 4769.4 4774.6 4785.6 4809.9 4990.9 4997.5 4999.6 4999.9 5051.1 4606.5 4643.7 4660.0 4685.6 4697.9 4677.4 4701.0 4701.8 4711.7 4748.5 4509.6 4634.6 4653.0 4694.5 4705.6 4708.4 4727.5 4780.1 4781.0 4799.1 4660.7 4683.6 4683.8 4687.4 4728.4 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#1] ext.html Cycles:180 Average:49658.57 Median:352951.50 stddev:91715.95 (26.0%) stddev-sans-first:91899.19 04:35:22 INFO - PROCESS | 17993 | Values: 573.5 589.5 595.5 616.8 621.3 39040.4 40772.0 40862.6 43882.0 44178.3 40621.6 41354.8 41656.8 41706.0 41732.0 7264.2 8019.8 8154.0 8175.5 10345.4 10261.8 10547.0 10559.2 10603.2 10613.3 10568.6 10611.5 10618.9 10621.5 10624.3 7662.5 7853.8 7859.1 10165.3 10445.7 10097.6 10438.4 10463.1 10466.3 10472.5 39349.0 39439.8 39572.6 39805.8 39836.8 2913.4 2950.5 3037.9 3084.8 3201.0 29979.9 30164.2 30655.0 30793.5 31511.0 3003.2 3097.3 3305.6 3357.3 3387.7 272253.0 272382.0 273744.0 274214.0 274298.0 55665.4 56005.7 56179.0 56179.0 56194.7 33529.7 34015.0 34289.1 35963.5 36261.6 12546.2 12574.9 12648.4 12663.3 12683.0 8534.9 9257.0 9485.8 9504.4 9639.1 18362.3 18415.4 18500.0 18586.9 18700.8 6565.1 6835.5 6875.4 6927.2 6950.3 774.5 872.8 882.9 889.4 924.9 27785.4 28118.3 28348.9 28515.4 28651.6 954.0 963.5 976.3 1041.3 1070.5 14874.9 15273.7 15276.0 15308.4 15399.6 402384.0 405648.0 405938.0 407350.0 408075.0 48780.3 50213.7 50267.0 50283.2 50305.7 1039.3 1079.1 1085.1 1158.4 1178.9 24307.6 31346.8 31400.0 31501.8 31736.7 46504.8 46899.0 46946.0 46955.5 46984.5 349614.0 352383.0 352715.0 353188.0 353788.0 25310.5 25392.1 26128.5 26147.9 27270.5 41711.6 41858.4 42383.0 42401.4 43112.8 35770.6 36545.5 36815.4 37107.0 37128.4 36429.6 36457.8 36513.1 36658.8 36969.3 35430.1 36344.3 37326.4 37403.0 39883.0 30687.7 32936.0 33288.2 33383.8 33685.7 22953.2 24060.6 24261.2 24279.8 24357.8 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#2] jquery.html Cycles:180 Average:23254.01 Median:4411.54 stddev:59705.66 (1353.4%) stddev-sans-first:59848.36 04:35:22 INFO - PROCESS | 17993 | Values: 339.5 359.5 362.7 365.3 380.4 13640.4 13981.9 14405.9 17510.6 17550.6 16799.5 17030.3 17772.4 17820.7 17845.5 4851.3 4981.2 4987.8 4991.9 4996.6 3554.6 5966.2 6276.2 6285.6 6422.9 5762.8 5885.0 6354.8 6385.4 6392.2 5720.7 5739.2 5759.5 5777.2 5786.7 4733.4 4998.9 5027.2 5545.8 5557.0 12600.2 12637.1 12690.7 12837.4 19655.0 1852.7 1931.4 1932.4 1941.7 2024.6 8895.8 9515.1 9538.4 9599.0 9814.8 1628.0 1739.7 1754.9 1764.8 1807.1 67112.0 70454.0 71679.6 73001.6 74661.6 9835.9 9836.7 10188.4 10312.7 10480.9 13987.0 14088.9 14106.6 14137.9 14139.4 6775.7 6857.4 6886.3 6952.1 7044.5 6398.3 6418.7 6422.4 6505.7 6530.6 4380.2 4395.6 4399.0 4424.1 4480.1 1836.7 1846.8 1850.5 1860.7 1861.3 833.0 867.0 878.4 910.7 913.2 16715.2 16976.7 17523.6 17634.9 17637.2 854.4 858.9 865.9 900.3 904.3 9495.8 9792.8 9796.9 9808.2 9816.9 357386.0 360184.0 362023.0 362044.0 363143.1 47697.8 53311.0 72436.6 72647.0 78749.0 890.8 908.6 924.7 947.9 955.3 12025.7 15353.2 15376.2 16370.1 16606.4 37963.4 38452.4 38986.4 39576.6 39966.8 50415.0 50994.0 57890.1 57916.7 58571.0 6607.8 7085.3 7264.7 7291.2 7448.3 10450.6 12006.4 12384.8 12435.0 12817.2 10544.2 10749.1 10791.6 10801.5 10934.7 10343.4 10579.8 10611.7 10626.8 10779.3 10697.6 10735.8 10788.2 10836.1 11036.5 7089.4 7157.1 7176.5 7383.7 7435.2 8379.7 10447.2 10578.9 10665.8 10846.9 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#3] mootools.html Cycles:180 Average:4939.10 Median:5165.06 stddev:2705.76 (52.4%) stddev-sans-first:2698.81 04:35:22 INFO - PROCESS | 17993 | Values: 1206.2 1212.5 1338.0 1369.8 1371.8 7237.7 7595.5 7701.1 7709.0 7731.4 6495.9 6671.2 6671.4 6810.7 7498.8 1894.5 2107.6 2182.1 2198.6 2204.9 2147.9 2171.1 2174.8 2180.1 2203.6 1875.9 2191.9 2200.1 2200.9 2201.9 1846.5 1852.6 2097.5 2150.1 2158.7 2120.2 2122.7 2124.9 2126.1 2128.9 7497.3 7547.5 7549.2 7551.8 7554.4 4513.0 4605.1 4626.8 4649.0 4658.2 2804.1 2864.3 2873.2 2876.5 2898.0 900.9 929.9 944.7 945.3 959.2 10001.5 10031.7 10074.6 10104.1 10116.6 4080.7 4151.7 4311.0 4315.1 4320.3 8542.2 8592.1 8609.7 8620.8 8638.6 4605.9 4638.8 4659.6 4659.6 4666.0 4054.4 4199.9 4200.2 4244.1 4259.9 3519.5 3561.0 3608.0 3638.5 3654.1 1142.6 1145.5 1156.3 1158.5 1161.7 774.2 781.3 785.0 799.0 821.2 4910.2 5005.1 5179.8 5263.3 5270.5 400.6 886.7 890.7 926.1 947.9 3356.1 3496.1 3516.0 3525.7 3545.2 8798.9 9126.4 9133.6 9135.8 9160.7 8982.6 9053.1 9058.4 9063.5 9087.9 7064.1 7184.4 7192.8 7202.0 7222.6 4863.5 5103.4 5150.3 5273.2 5387.5 8231.0 8325.7 8342.4 8380.7 8423.0 8279.3 8321.5 8437.6 8447.9 8650.9 5912.6 6397.7 6540.0 6544.2 6622.7 7221.1 7241.2 7315.6 7322.9 7334.6 6459.1 6470.2 6560.2 6615.6 6706.0 6339.1 6379.7 6409.0 6444.9 6532.9 6112.5 6132.1 6178.8 6181.5 6191.8 4381.1 4383.3 4430.5 4456.2 4457.1 4311.2 4326.4 4342.5 4465.3 4475.3 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#4] prototype.html Cycles:180 Average:4234.66 Median:4888.10 stddev:1216.36 (24.9%) stddev-sans-first:1183.34 04:35:22 INFO - PROCESS | 17993 | Values: 298.0 304.9 308.3 309.2 309.9 4921.8 4946.0 4952.9 4960.8 4971.8 4876.9 4904.7 4906.1 4919.7 4926.7 3667.8 3763.3 3803.3 3839.7 3842.3 3796.5 3852.5 3869.3 3885.1 3885.8 3814.2 3819.4 3826.0 3835.7 3851.0 3649.5 3730.1 3834.7 3858.4 3864.8 3372.0 3375.3 3408.1 3424.2 3432.6 4720.2 4750.5 4792.7 4816.2 4820.6 4162.4 4344.5 4345.2 4363.4 4377.9 5044.3 5052.4 5059.5 5067.2 5076.6 3689.8 3701.5 3713.8 3716.3 3724.7 5140.7 5271.1 5361.6 5368.7 5381.9 3764.3 3769.4 3784.4 3793.6 3798.3 3856.0 3860.7 3863.2 3866.8 3870.3 4347.8 4378.1 4379.0 4389.7 4400.8 4900.2 5106.5 5114.5 5138.8 5148.5 1291.1 1302.5 1303.8 1305.2 1310.1 835.4 838.9 849.7 871.9 895.3 4439.7 4456.9 4459.8 4461.2 4463.1 5180.2 5202.7 5230.6 5248.7 5251.6 4280.8 4389.2 4411.9 4429.4 4439.2 2791.4 2803.0 2805.2 2813.2 2820.6 4924.0 4928.7 4933.7 4937.0 4951.3 5241.9 5411.7 5431.8 5435.0 5503.1 4932.0 4935.6 4961.2 4976.7 4980.2 5281.3 5303.6 5307.5 5310.1 5350.2 4954.0 5196.3 5236.2 5246.5 5257.0 4911.6 4933.5 4935.1 4938.0 4954.5 3742.0 3753.8 3768.6 3770.4 3773.8 5061.9 5218.8 5314.5 5324.3 5330.6 4899.3 4906.5 4909.1 4909.7 4931.8 4902.7 4946.3 4988.4 4990.2 4992.8 4672.7 4933.2 4935.9 4941.9 4972.3 4775.9 4868.7 4965.3 4985.1 4993.3 4835.8 4845.2 4922.2 4927.4 4932.0 04:35:22 INFO - PROCESS | 17993 | 04:35:22 INFO - PROCESS | 17993 | [#5] yui.html Cycles:180 Average:17834.73 Median:502.70 stddev:25381.06 (5049.0%) stddev-sans-first:25419.36 04:35:22 INFO - PROCESS | 17993 | Values: 621.5 653.0 696.8 698.5 722.1 12004.4 12714.5 12776.0 14672.0 15204.0 14871.7 14908.1 15000.8 15015.5 15021.5 634.6 649.5 783.5 785.4 802.5 804.1 806.6 811.3 813.6 815.5 854.3 856.7 857.0 857.0 857.4 657.9 670.8 675.2 675.3 848.5 591.7 604.1 604.3 605.1 607.7 12891.8 12923.2 12928.5 12961.9 12965.2 11907.2 12574.7 12592.9 12771.7 12873.2 11501.1 11583.4 11655.2 11736.4 11931.2 3698.7 3743.5 3762.5 3770.2 3804.8 61787.0 63234.4 63310.4 63546.7 63636.0 9705.2 9812.0 9829.2 9842.0 10017.6 17341.7 17364.0 17410.4 17418.2 17431.7 6359.1 6419.5 6428.9 6517.6 6607.8 3507.0 3534.0 3584.2 3664.4 3690.6 2609.2 2724.7 2727.5 2732.1 2738.4 481.4 483.5 494.3 504.3 504.3 424.1 495.8 510.0 534.4 549.5 7337.6 7415.2 7428.9 7534.5 7544.0 457.6 475.6 501.8 503.6 504.6 3434.7 3543.5 3600.2 3633.4 3775.6 91142.0 91689.0 94613.0 97057.0 97250.0 80157.0 82974.0 84919.0 84921.0 85690.6 71583.6 75852.6 76657.6 77152.2 78035.8 7205.8 7230.4 7292.1 7421.1 8600.6 32268.0 43518.6 44285.6 44456.2 48092.0 65290.3 68008.3 68295.3 68376.0 68539.3 10685.3 11052.1 11274.8 11530.5 11541.3 13655.6 13708.9 13763.1 13978.7 14342.0 11505.1 11571.8 11659.8 11878.3 12272.3 11863.4 11870.8 12085.2 12681.7 12742.6 12021.9 12482.9 12746.5 12894.8 13020.7 9393.0 9537.8 9657.9 10006.8 10040.7 8844.6 9165.7 9706.6 9770.9 9831.3 04:35:22 INFO - PROCESS | 17993 | -------- Summary: end -------- 04:35:22 INFO - PROCESS | 17993 | 04:35:23 INFO - TEST-INFO | 17993: exit 0 04:35:23 INFO - TEST-OK | dromaeo_css | took 1118888ms 04:35:23 INFO - TEST-START | kraken 04:35:23 INFO - operating with platform_type : linux_ 04:35:23 INFO - Initialising browser for kraken test... 04:35:23 INFO - TEST-INFO | started process 18179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP944MS/profile http://localhost:39614/getInfo.html) 04:35:27 INFO - PROCESS | 18179 | __metrics Screen width/height:1600/1200 04:35:27 INFO - PROCESS | 18179 | colorDepth:24 04:35:27 INFO - PROCESS | 18179 | Browser inner width/height: 1024/697 04:35:27 INFO - PROCESS | 18179 | __metrics 04:35:28 INFO - PROCESS | 18179 | 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" 04:35:28 INFO - PROCESS | 18179 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:29 INFO - TEST-INFO | 18179: exit 0 04:35:29 INFO - Browser initialized. 04:35:29 INFO - Running cycle 1/1 for kraken test... 04:35:29 INFO - TEST-INFO | started process 18260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP944MS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:41 INFO - PROCESS | 18260 | RSS: Main: 159019008 04:35:41 INFO - PROCESS | 18260 | 04:35:44 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:45 INFO - PROCESS | 18260 | RSS: Main: 217096192 04:35:45 INFO - PROCESS | 18260 | 04:35:48 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-dft) 04:35:48 INFO - PROCESS | 18260 | RSS: Main: 206352384 04:35:48 INFO - PROCESS | 18260 | 04:35:51 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-fft) 04:35:52 INFO - PROCESS | 18260 | RSS: Main: 271290368 04:35:52 INFO - PROCESS | 18260 | 04:35:54 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-oscillator) 04:35:55 INFO - PROCESS | 18260 | RSS: Main: 181231616 04:35:55 INFO - PROCESS | 18260 | 04:35:57 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:58 INFO - PROCESS | 18260 | RSS: Main: 185917440 04:35:58 INFO - PROCESS | 18260 | 04:36:01 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:02 INFO - PROCESS | 18260 | RSS: Main: 221499392 04:36:02 INFO - PROCESS | 18260 | 04:36:05 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:06 INFO - PROCESS | 18260 | RSS: Main: 217796608 04:36:06 INFO - PROCESS | 18260 | 04:36:09 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39614/tests/kraken/driver.html?testName=json-parse-financial) 04:36:09 INFO - PROCESS | 18260 | RSS: Main: 220422144 04:36:09 INFO - PROCESS | 18260 | 04:36:11 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:12 INFO - PROCESS | 18260 | RSS: Main: 207327232 04:36:12 INFO - PROCESS | 18260 | 04:36:13 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:14 INFO - PROCESS | 18260 | RSS: Main: 211369984 04:36:14 INFO - PROCESS | 18260 | 04:36:16 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:17 INFO - PROCESS | 18260 | RSS: Main: 209731584 04:36:17 INFO - PROCESS | 18260 | 04:36:20 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:20 INFO - PROCESS | 18260 | RSS: Main: 222498816 04:36:20 INFO - PROCESS | 18260 | 04:36:23 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:24 INFO - PROCESS | 18260 | RSS: Main: 223805440 04:36:24 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39614/tests/kraken/driver.html?testName=ai-astar) 04:36:26 INFO - PROCESS | 18260 | RSS: Main: 265773056 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | __start_tp_report 04:36:26 INFO - PROCESS | 18260 | _x_x_mozilla_page_load 04:36:26 INFO - PROCESS | 18260 | _x_x_mozilla_page_load_details 04:36:26 INFO - PROCESS | 18260 | |i|pagename|runs| 04:36:26 INFO - PROCESS | 18260 | |0;ai-astar;107;116;116;115;114;115;114;115;116;117 04:36:26 INFO - PROCESS | 18260 | |1;audio-beat-detection;151;125;125;176;129;124;147;130;162;123 04:36:26 INFO - PROCESS | 18260 | |2;audio-dft;162;161;161;161;163;162;165;163;162;165 04:36:26 INFO - PROCESS | 18260 | |3;audio-fft;76;76;76;127;79;77;76;76;99;79 04:36:26 INFO - PROCESS | 18260 | |4;audio-oscillator;86;86;128;85;85;85;125;85;87;132 04:36:26 INFO - PROCESS | 18260 | |5;imaging-gaussian-blur;117;118;117;117;118;116;117;117;117;117 04:36:26 INFO - PROCESS | 18260 | |6;imaging-darkroom;146;147;146;147;147;146;147;146;146;147 04:36:26 INFO - PROCESS | 18260 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 04:36:26 INFO - PROCESS | 18260 | |8;json-parse-financial;69;64;64;64;67;68;66;66;66;66 04:36:26 INFO - PROCESS | 18260 | |9;json-stringify-tinderbox;65;65;65;66;67;65;65;66;65;66 04:36:26 INFO - PROCESS | 18260 | |10;stanford-crypto-aes;80;80;80;79;79;82;86;79;80;81 04:36:26 INFO - PROCESS | 18260 | |11;stanford-crypto-ccm;137;134;130;129;130;136;128;134;169;140 04:36:26 INFO - PROCESS | 18260 | |12;stanford-crypto-pbkdf2;174;166;166;170;167;166;166;165;167;166 04:36:26 INFO - PROCESS | 18260 | |13;stanford-crypto-sha256-iterative;67;69;69;73;67;66;68;66;67;66 04:36:26 INFO - PROCESS | 18260 | __end_tp_report 04:36:26 INFO - PROCESS | 18260 | __start_cc_report 04:36:26 INFO - PROCESS | 18260 | _x_x_mozilla_cycle_collect,1930 04:36:26 INFO - PROCESS | 18260 | __end_cc_report 04:36:26 INFO - PROCESS | 18260 | __startTimestamp1468236986311__endTimestamp 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | ------- Summary: start ------- 04:36:26 INFO - PROCESS | 18260 | Number of tests: 14 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:2.80 (2.4%) stddev-sans-first:1.00 04:36:26 INFO - PROCESS | 18260 | Values: 107.0 116.0 116.0 115.0 114.0 115.0 114.0 115.0 116.0 117.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:138.50 stddev:18.74 (13.5%) stddev-sans-first:19.38 04:36:26 INFO - PROCESS | 18260 | Values: 151.0 125.0 125.0 176.0 129.0 124.0 147.0 130.0 162.0 123.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 04:36:26 INFO - PROCESS | 18260 | Values: 162.0 161.0 161.0 161.0 163.0 162.0 165.0 163.0 162.0 165.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#3] audio-fft Cycles:10 Average:84.10 Median:76.50 stddev:16.64 (21.8%) stddev-sans-first:17.39 04:36:26 INFO - PROCESS | 18260 | Values: 76.0 76.0 76.0 127.0 79.0 77.0 76.0 76.0 99.0 79.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:85.00 stddev:20.73 (24.4%) stddev-sans-first:21.50 04:36:26 INFO - PROCESS | 18260 | Values: 86.0 86.0 128.0 85.0 85.0 85.0 125.0 85.0 87.0 132.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:36:26 INFO - PROCESS | 18260 | Values: 117.0 118.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:36:26 INFO - PROCESS | 18260 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:36:26 INFO - PROCESS | 18260 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.41 04:36:26 INFO - PROCESS | 18260 | Values: 69.0 64.0 64.0 64.0 67.0 68.0 66.0 66.0 66.0 66.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:36:26 INFO - PROCESS | 18260 | Values: 65.0 65.0 65.0 66.0 67.0 65.0 65.0 66.0 65.0 66.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.12 (2.6%) stddev-sans-first:2.24 04:36:26 INFO - PROCESS | 18260 | Values: 80.0 80.0 80.0 79.0 79.0 82.0 86.0 79.0 80.0 81.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:135.00 stddev:11.99 (8.9%) stddev-sans-first:12.72 04:36:26 INFO - PROCESS | 18260 | Values: 137.0 134.0 130.0 129.0 130.0 136.0 128.0 134.0 169.0 140.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.50 stddev:2.71 (1.6%) stddev-sans-first:1.42 04:36:26 INFO - PROCESS | 18260 | Values: 174.0 166.0 166.0 170.0 167.0 166.0 166.0 165.0 167.0 166.0 04:36:26 INFO - PROCESS | 18260 | 04:36:26 INFO - PROCESS | 18260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.15 (3.2%) stddev-sans-first:2.26 04:36:26 INFO - PROCESS | 18260 | Values: 67.0 69.0 69.0 73.0 67.0 66.0 68.0 66.0 67.0 66.0 04:36:26 INFO - PROCESS | 18260 | -------- Summary: end -------- 04:36:26 INFO - PROCESS | 18260 | 04:36:27 INFO - TEST-INFO | 18260: exit 0 04:36:27 INFO - TEST-OK | kraken | took 64058ms 04:36:27 INFO - SUITE-END | took 1182s 04:36:27 INFO - Completed test suite (00:19:43) 04:36:27 INFO - javascript benchmark 04:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2531.164715643837, 2558.705748838882, 2603.6485074514935, 2613.3858543242336, 2615.189291319691, 4558.407407037081, 4624.09830083134, 4669.206234940059, 4700.717956922587, 4727.243641017438, 4660.0, 4666.323383109447, 4673.696209746364, 4700.0, 4706.082313948781, 4264.59486348798, 4288.592583704543, 4337.414449049385, 4349.69552131351, 4364.7817609119575, 34.41032515189334, 4382.934255986147, 4384.934225986613, 4390.121975604876, 4411.382406463082, 4208.768517731523, 4247.893802654959, 4270.295401258789, 4372.606465418112, 4397.812590600536, 4292.935605965882, 4300.978495107535, 4304.80628371724, 4305.870823875289, 4312.5903039211225, 4275.551067137937, 4281.614654681093, 4296.570342965679, 4307.719998200107, 4330.783460826978, 4701.200795864711, 4747.905041899177, 4751.596114330286, 4752.572268495852, 4752.809887604526, 5073.746312684351, 5080.0, 5081.415637201732, 5086.262491938648, 5089.262057001751, 4927.975360123212, 4937.1606826839525, 4975.701457912501, 4988.975055124737, 5076.111680455905, 4694.293816228035, 4761.2382018876815, 4782.33047373368, 4784.712917224942, 4788.209945358977, 5143.305653736697, 5225.686458812484, 5226.0, 5235.267062611238, 5237.711925844039, 4747.287906813936, 4854.781534830941, 4908.01839632075, 4982.153033984231, 5007.499250075036, 5021.447640759514, 5064.392272927199, 5064.392272927273, 5069.493050694975, 5074.441811400743, 4981.37732783402, 4990.875228119254, 4993.725345106054, 5018.4981501849525, 5035.899282014339, 4726.574608285271, 4857.1742803723455, 4901.019796040806, 4921.680090794087, 4955.132851750929, 4196.538380778112, 4200.201961627281, 4209.515905670826, 4210.200061988213, 4222.577742225752, 3672.338978983755, 3674.026383008505, 3677.0, 3707.0, 3718.2749363874327, 4176.2900306947895, 4195.622393984556, 4224.809883555247, 4289.9571004289555, 4302.075053863435, 5006.574441172541, 5038.5969122470115, 5040.0, 5042.117629414911, 5079.923801142986, 4299.054208074282, 4301.0537681709975, 4306.612404883575, 4339.500957389878, 4350.086481838849, 4378.605925466723, 4403.867883963486, 4472.127935052698, 4498.640108791289, 4501.572350626685, 4642.16441040616, 4653.883652908637, 4660.836870709577, 4674.6026587740425, 4738.0, 4993.226049962262, 5028.497150284942, 5031.345925029723, 5047.621428392812, 5081.949180508148, 4522.457305123275, 4555.362249285036, 4577.107464044612, 4611.976940115278, 4697.342372067981, 4752.19212733843, 4769.356136921471, 4774.641901857444, 4785.617150628011, 4809.879753006203, 4990.900181996267, 4997.525235102659, 4999.550040496373, 4999.925001125059, 5051.141305978066, 4606.539346065367, 4643.674942753974, 4660.0, 4685.625149988061, 4697.906041879211, 4677.391939048038, 4701.03628756111, 4701.835435759732, 4711.717296962193, 4748.548887855648, 4509.571590698878, 4634.606058485067, 4652.953085555723, 4694.483606803181, 4705.576498115049, 4708.387909571734, 4727.456342520654, 4780.091782561302, 4781.043791241835, 4799.112164249625, 4660.6970546914345, 4683.601893838925, 4683.8360657376825, 4687.414073240845, 4728.361671174347], "value": 4533.602217632696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4638113364005, 589.5224867857036, 595.5295316699808, 616.8211218746563, 621.2700077409044, 39040.414393784115, 40772.0, 40862.59137408629, 43882.0, 44178.33732494015, 40621.59378406215, 41354.7932260339, 41656.79171604145, 41706.0, 41732.0, 7264.200937896853, 8019.759407217793, 8154.0, 8175.509469431853, 10345.37927724339, 10261.79476410475, 10547.0, 10559.208059395538, 10603.204759643018, 10613.257072004924, 10568.577256909715, 10611.522481488351, 10618.946905265502, 10621.522031508563, 10624.256302058859, 7662.463627546074, 7853.842923141505, 7859.135495095535, 10165.339252948535, 10445.68662940113, 10097.646582369654, 10438.425886576235, 10463.058324750733, 10466.319689220176, 10472.476376181237, 39349.0, 39439.80280098581, 39572.60427395718, 39805.80097099496, 39836.80081599573, 2913.373624670706, 2950.468915595192, 3037.878484860603, 3084.7532197424152, 3200.983995080033, 29979.850100749576, 30164.24589385283, 30655.0, 30793.538096928565, 31511.0, 3003.1591154476564, 3097.3340731742783, 3305.6198537168293, 3357.3285342931513, 3387.745919056056, 272253.0, 272382.0, 273744.0, 274214.0, 274298.0, 55665.44334556683, 56005.719971399885, 56179.0, 56179.0, 56194.71902640461, 33529.66470335314, 34015.0, 34289.14277143091, 35963.460548091796, 36261.63738362635, 12546.1844980076, 12574.87425125737, 12648.430820613094, 12663.303518306582, 12683.0, 8534.87197692035, 9256.95371523138, 9485.762855928657, 9504.42973421597, 9639.132478076866, 18362.265509379744, 18415.447536573924, 18500.0, 18586.907065464588, 18700.81299186991, 6565.146530950946, 6835.521513494008, 6875.449964002868, 6927.203371612229, 6950.3049695030095, 774.4810976645548, 872.7556284240422, 882.8631562107884, 889.3996552327283, 924.8705181274627, 27785.444291114065, 28118.29704257369, 28348.858255709, 28515.429691406054, 28651.57022644662, 953.9570719317647, 963.4700914496999, 976.277554609598, 1041.3231399590175, 1070.475467021154, 14874.851251487347, 15273.694526109415, 15276.0, 15308.387664493519, 15399.614034736704, 402384.0, 405648.0, 405938.0, 407350.0, 408075.0, 48780.26829597559, 50213.74893125511, 50267.0, 50283.245751313756, 50305.74847125741, 1039.308859608352, 1079.0935614083894, 1085.0939465546198, 1158.3918442817587, 1178.9410529473491, 24307.635385469584, 31346.843265783526, 31400.0, 31501.8424907874, 31736.682633173372, 46504.7674761624, 46899.0, 46946.0, 46955.53044469511, 46984.53015469802, 349614.0, 352383.0, 352715.0, 353188.0, 353788.0, 25310.493790124463, 25392.111276105246, 26128.477430451665, 26147.869260653573, 27270.454590908466, 41711.58288417077, 41858.37212441877, 42383.0, 42401.36397953972, 43112.78443607762, 35770.56917723366, 36545.45181822222, 36815.44776828403, 37107.0, 37128.443073354465, 36429.63570364368, 36457.81771091127, 36513.08717281983, 36658.816705917365, 36969.260614788094, 35430.114247143, 36344.27311453809, 37326.44010339793, 37403.0, 39883.0, 30687.693123069377, 32936.0, 33288.1677958053, 33383.83308083444, 33685.663143368256, 22953.196638117584, 24060.639090414006, 24261.150859720532, 24279.75720242775, 24357.75642243555], "value": 17990.20125710245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5127991332437, 359.49131978250773, 362.73339095764624, 365.26034779571376, 380.43315459964646, 13640.386182621782, 13981.930090349559, 14405.927970360146, 17510.562235944075, 17550.648987020253, 16799.496015119534, 17030.318787248525, 17772.377966771164, 17820.73268900964, 17845.46463606094, 4851.272309153629, 4981.203007518798, 4987.8254261100865, 4991.875203119915, 4996.5503104720565, 3554.591222009476, 5966.194563733906, 6276.152719382893, 6285.591436556632, 6422.903656445157, 5762.769489220426, 5885.028970219909, 6354.7775827846035, 6385.425311721944, 6392.23293204816, 5720.742566584493, 5739.225204597367, 5759.539236861083, 5777.191193232929, 5786.710664466802, 4733.408323959505, 4998.925231075336, 5027.220780778948, 5545.77816887324, 5557.027520183992, 12600.243985360816, 12637.115401921868, 12690.682732931658, 12837.358132093357, 19655.0, 1852.6757817381904, 1931.3916116423281, 1932.3623204342534, 1941.7184508246366, 2024.6052019856133, 8895.764842390243, 9515.143637072628, 9538.427694338361, 9598.95200523993, 9814.75463113428, 1627.9674406511922, 1739.7129473636835, 1754.8508376787988, 1764.80587135415, 1807.0874208524742, 67112.0, 70454.0, 71679.64160179217, 73001.6349918247, 74661.62669186619, 9835.852462213072, 9836.704898853046, 10188.388696678223, 10312.690619281433, 10480.895191048145, 13987.0, 14088.929555352157, 14106.576802695936, 14137.939654525951, 14139.434422623186, 6775.661216939134, 6857.382835544725, 6886.311368863174, 6952.130983627047, 7044.471664625174, 6398.328175541501, 6418.6797245176, 6422.42198202164, 6505.674716264168, 6530.608163510205, 4380.211561918885, 4395.648348132142, 4398.971876325719, 4424.11517696462, 4480.059187570581, 1836.728588949723, 1846.8060853610446, 1850.4726153046317, 1860.702287633999, 1861.3392245752834, 833.0, 867.0159369116099, 878.4246318661287, 910.717677519971, 913.1918252346721, 16715.164241788105, 16976.74534881978, 17523.56191095233, 17634.91182544079, 17637.206325715375, 854.4189950833369, 858.8797568340437, 865.8614621660504, 900.2752784008935, 904.2765787370209, 9495.76260593477, 9792.804143917225, 9796.9020309796, 9808.21534277256, 9816.90105662831, 357386.0, 360184.0, 362023.0, 362044.0, 363143.1328337068, 47697.76151119292, 53311.0, 72436.63781681164, 72647.0, 78749.0, 890.8485557455248, 908.6229214875884, 924.7179610218814, 947.8862536495665, 955.3264948211494, 12025.699357516132, 15353.232338383259, 15376.154311512973, 16370.099644519665, 16606.418775342805, 37963.43054854235, 38452.42321365238, 38986.4152037714, 39576.604233958446, 39966.80016599898, 50415.0, 50994.0, 57890.13164802615, 57916.71041644765, 58571.0, 6607.834804129743, 7085.291470852873, 7264.67308971087, 7291.197968223597, 7448.329650331496, 10450.581976720847, 12006.399680016139, 12384.75230495403, 12435.0, 12817.1668841525, 10544.209184311054, 10749.14006879432, 10791.568337266735, 10801.541791857999, 10934.726631834268, 10343.43111128865, 10579.841302380317, 10611.681649550526, 10626.787464250827, 10779.299345542515, 10697.572097116028, 10735.785284294427, 10788.190885683449, 10836.133109351076, 11036.503357348778, 7089.397401220954, 7157.141143062866, 7176.461765367514, 7383.667734951832, 7435.182129965808, 8379.70671026511, 10447.216458765472, 10578.947105264733, 10665.786684266115, 10846.891531084588], "value": 8140.727960258844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1206.167744256463, 1212.4907538833688, 1338.0232430325862, 1369.8424681161669, 1371.773657346538, 7237.7104915803375, 7595.50629209101, 7701.114371847239, 7709.0, 7731.420143489233, 6495.870082598345, 6671.166104236971, 6671.432928201109, 6810.693518791654, 7498.775036748906, 1894.5358387195122, 2107.6311645461983, 2182.1053368119074, 2198.5932602468515, 2204.8677079375207, 2147.871127732333, 2171.0989939175224, 2174.7825217478285, 2180.062573093569, 2203.55928814237, 1875.8593105517073, 2191.860232679006, 2200.108955872866, 2200.90095945682, 2201.8678879267213, 1846.547595839028, 1852.6109517001378, 2097.4651463876767, 2150.064721846002, 2158.719366482363, 2120.151939224307, 2122.724045874042, 2124.915003399862, 2126.0645316061036, 2128.861623994451, 7497.250274972459, 7547.471676982614, 7549.245075492462, 7551.773446796605, 7554.395648348119, 4512.977435112836, 4605.102005109005, 4626.843289177706, 4648.976755116203, 4658.231391820345, 2804.1307194769483, 2864.3268831824503, 2873.2385917731817, 2876.5397536394075, 2898.043645596948, 900.8648702694583, 929.8930622978377, 944.6976967370445, 945.2957546627738, 959.2230293462318, 10001.49992500372, 10031.699049028468, 10074.647387341482, 10104.141148002429, 10116.595336186543, 4080.6531444827524, 4151.667866570728, 4311.0, 4315.093830295673, 4320.287152619845, 8542.18849209324, 8592.140785921358, 8609.69866054685, 8620.78448038804, 8638.56807159652, 4605.907881842344, 4638.768061596974, 4659.602119364177, 4659.627229821606, 4665.95334046662, 4054.432379466877, 4199.887029937069, 4200.243956087934, 4244.066305412866, 4259.914801703949, 3519.472079188091, 3560.9821950890077, 3608.0438683748825, 3638.5451818522683, 3654.14127679995, 1142.5544037825255, 1145.5360578965533, 1156.2715489241723, 1158.5423757615695, 1161.692151579832, 774.2257742257742, 781.3397678961269, 784.9764507064797, 799.0371602219312, 821.2403526737744, 4910.165271903785, 5005.099082165172, 5179.8446046618665, 5263.315768950012, 5270.49930256625, 400.6494317472212, 886.7472770260445, 890.6749036601594, 926.0878035135386, 947.9004704506066, 3356.1360590313125, 3496.1434448560267, 3516.043380144177, 3525.7003154732133, 3545.2200515886466, 8798.912010879809, 9126.36115471924, 9133.588988495534, 9135.77160570991, 9160.6793762218, 8982.550872456351, 9053.094690530894, 9058.411203271766, 9063.456192628464, 9087.909120908838, 7064.081669382947, 7184.389326907271, 7192.784216473514, 7201.991721159042, 7222.638868056576, 4863.4650188479945, 5103.362079740033, 5150.278960945546, 5273.156294992783, 5387.488188622075, 8231.0, 8325.666973321, 8342.374321925758, 8380.664773408995, 8422.957885210535, 8279.254867061993, 8321.54231517248, 8437.578121093798, 8447.873281900653, 8650.870236946324, 5912.61567998096, 6397.712102955285, 6540.0, 6544.247411547733, 6622.668866556556, 7221.061262035902, 7241.167265764505, 7315.597642129521, 7322.890156647548, 7334.606424779275, 6459.128017717736, 6470.191226096738, 6560.245571759308, 6615.636140012345, 6705.966470167618, 6339.1125242467015, 6379.681015949277, 6409.0, 6444.871102577828, 6532.869342613216, 6112.510999120149, 6132.08018797184, 6178.814635560941, 6181.505479561534, 6191.81424557264, 4381.145676593033, 4383.276759334674, 4430.534793846599, 4456.197884380713, 4457.108578284421, 4311.2455320318195, 4326.372675962031, 4342.457192850894, 4465.330200469955, 4475.30632751924], "value": 3995.324768371619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9925501862453, 304.91919641295044, 308.26325083051495, 309.23155957445744, 309.8714033676026, 4921.753912304383, 4945.9505404945985, 4952.87617809554, 4960.767654555451, 4971.776270067847, 4876.902461950768, 4904.705717656943, 4906.062105468347, 4919.655624106314, 4926.704397736138, 3667.7615954962907, 3763.303788799067, 3803.3344164771192, 3839.6736277416453, 3842.346801043829, 3796.4874741909903, 3852.5376954765466, 3869.284182426246, 3885.0870045539277, 3885.8251378687887, 3814.179951310468, 3819.4461803038544, 3825.9808700956455, 3835.654791068803, 3850.9614903851025, 3649.489071529988, 3730.1047748540427, 3834.69322454203, 3858.3633700439395, 3864.768113913146, 3372.0389688938535, 3375.3418083473734, 3408.1479630092476, 3424.195314101184, 3432.5880894292595, 4720.244760838249, 4750.524947505256, 4792.736399498026, 4816.205326121186, 4820.63845211607, 4162.438070860426, 4344.545331887473, 4345.174416860787, 4363.38912552243, 4377.934330985037, 5044.344235249394, 5052.393712754456, 5059.494050594948, 5067.239914012891, 5076.6192535559985, 3689.8339574719203, 3701.5002974598624, 3713.7771733695795, 3716.312482190803, 3724.7392682512236, 5140.7172605506685, 5271.128749294022, 5361.597880159004, 5368.70472124033, 5381.919271210935, 3764.3036038333, 3769.3780526212868, 3784.356659367859, 3793.6016718244186, 3798.2783271178387, 3855.9974406654474, 3860.749051311656, 3863.2273545291055, 3866.845326186921, 3870.3420418528917, 4347.847825326162, 4378.124375124988, 4378.978105109454, 4389.692721509464, 4400.845970391021, 4900.215965445512, 5106.489351064938, 5114.514121158484, 5138.845834624967, 5148.4851514848215, 1291.1155858237137, 1302.5411539076295, 1303.8395827713343, 1305.2038256663427, 1310.0894878059848, 835.3567752830287, 838.9303637861775, 849.7110982266059, 871.877937088808, 895.2569367425021, 4439.711418757771, 4456.930336719164, 4459.777011149495, 4461.219286624828, 4463.129689710475, 5180.222966555047, 5202.687838729688, 5230.63385563007, 5248.6588371755715, 5251.632385733038, 4280.785960701953, 4389.18800021997, 4411.867643970686, 4429.424174857248, 4439.178751930903, 2791.441711657636, 2803.018943369804, 2805.1584524642526, 2813.198238502017, 2820.562812764025, 4924.0, 4928.728919909439, 4933.728644924564, 4936.963237720119, 4951.306817045616, 5241.868953276198, 5411.675299482044, 5431.8098866539485, 5435.0, 5503.11950087992, 4931.964287499665, 4935.605151587864, 4961.181405068195, 4976.651634385558, 4980.178270585386, 5281.257185128975, 5303.628745987744, 5307.495787900143, 5310.097283461898, 5350.224217488365, 4954.0, 5196.298499702643, 5236.188390799432, 5246.527812496894, 5257.0, 4911.624745071385, 4933.531314525115, 4935.136351138464, 4937.975310123426, 4954.504549545017, 3742.0083677824855, 3753.793541355142, 3768.566614839219, 3770.359038963438, 3773.8301776419576, 5061.936993231463, 5218.764366093046, 5314.4951229633125, 5324.334458192726, 5330.573554115584, 4899.289603007615, 4906.460289368238, 4909.140900342354, 4909.705417674951, 4931.753412329441, 4902.7058376497525, 4946.282788995503, 4988.401391833003, 4990.226514890198, 4992.775325110451, 4672.74299913508, 4933.235348520985, 4935.901281974412, 4941.851744447672, 4972.328735620645, 4775.928361074656, 4868.683535570177, 4965.304857319906, 4985.052839960396, 4993.2510123480315, 4835.8065677372515, 4845.176320025675, 4922.1632322505975, 4927.359443272351, 4931.964287499665], "value": 3847.92921913969, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5121129913018, 652.9738810447583, 696.7839969609419, 698.4901022253755, 722.1442590530226, 12004.399780010997, 12714.491420343198, 12776.0, 14672.0, 15204.0, 14871.7025659487, 14908.105513669187, 15000.849991500081, 15015.47445839396, 15021.549353519413, 634.6319134901746, 649.54207283865, 783.4946459533597, 785.3599316557016, 802.5265093594778, 804.1355542791493, 806.6249194124731, 811.3144392987916, 813.5932033983008, 815.5188438821094, 854.3165467625905, 856.6830272799042, 856.9914300857005, 857.0272740439584, 857.395536147018, 657.8519833037576, 670.7618795327686, 675.2302375292171, 675.2740803636111, 848.520585868982, 591.7100620695871, 604.1421181921681, 604.2929772166576, 605.1467430922378, 607.7022259093056, 12891.80662290057, 12923.22460652364, 12928.54750083752, 12961.870381296161, 12965.157264777854, 11907.22603030809, 12574.748505029847, 12592.874071259263, 12771.744565108738, 12873.22760634365, 11501.069222239803, 11583.420828958519, 11655.242409243372, 11736.413179341083, 11931.164818462712, 3698.7410881238325, 3743.494628225209, 3762.4544441055896, 3770.2082562661876, 3804.847806087781, 61787.0, 63234.36765632331, 63310.36689633091, 63546.682266588374, 63636.0, 9705.17506011997, 9812.0, 9829.164521015793, 9841.950790246003, 10017.649382271731, 17341.65316693684, 17363.95816251029, 17410.39063632767, 17418.216180271917, 17431.65136697259, 6359.07793369968, 6419.45434638061, 6428.935710642927, 6517.641529715911, 6607.768728094494, 3506.964930350715, 3534.0, 3584.1756396028536, 3664.3953747631876, 3690.612485689018, 2609.1520255916903, 2724.727527247299, 2727.481778462086, 2732.098407525512, 2738.3564862257354, 481.4295060353492, 483.50199294726485, 494.2956287290597, 504.29902435614525, 504.3116146460129, 424.0839786062091, 495.7595566150414, 509.959203263738, 534.3774502704306, 549.4806859034773, 7337.596432196174, 7415.184329723834, 7428.925710742931, 7534.54792712439, 7544.0, 457.615602893571, 475.60049558371134, 501.79928028788777, 503.59963828755497, 504.634140248317, 3434.690877821008, 3543.450765131409, 3600.243948770735, 3633.4368172933237, 3775.5846856845724, 91142.0, 91689.0, 94613.0, 97057.0, 97250.0, 80157.0, 82974.0, 84919.0, 84921.0, 85690.57154714187, 71583.6420817903, 75852.62073689706, 76657.6167119172, 77152.22847771451, 78035.8294625581, 7205.772580243842, 7230.42156627479, 7292.088488938883, 7421.109466864011, 8600.569971501525, 32268.0, 43518.56481435145, 44285.557144428145, 44456.22069130992, 48092.0, 65290.34709653033, 68008.3199168002, 68295.3170468289, 68376.0, 68539.3146068533, 10685.305455145392, 11052.060574851228, 11274.759776424422, 11530.481128349076, 11541.307521548733, 13655.590332290047, 13708.93145534266, 13763.105398149088, 13978.720425591635, 14342.0, 11505.137114716263, 11571.768564628828, 11659.834016598612, 11878.287302761863, 12272.325022123869, 11863.40682965831, 11870.82193767077, 12085.214461060003, 12681.682957926125, 12742.61772146837, 12021.879781202426, 12482.937585312015, 12746.49014039428, 12894.806577901527, 13020.674483137997, 9392.95303523478, 9537.820154791218, 9657.903420965982, 10006.849897251692, 10040.748981275234, 8844.601992910206, 9165.721480785416, 9706.6117355305, 9770.902290977, 9831.262655300738], "value": 6474.625864151382, "unit": "score"}], "name": "dromaeo_css", "value": 6358.647809630336, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 116.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 125.0, 176.0, 129.0, 124.0, 147.0, 130.0, 162.0, 123.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 165.0, 163.0, 162.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 127.0, 79.0, 77.0, 76.0, 76.0, 99.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 128.0, 85.0, 85.0, 85.0, 125.0, 85.0, 87.0, 132.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "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, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 64.0, 64.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 79.0, 82.0, 86.0, 79.0, 80.0, 81.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 130.0, 129.0, 130.0, 136.0, 128.0, 134.0, 169.0, 140.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 166.0, 166.0, 170.0, 167.0, 166.0, 166.0, 165.0, 167.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 73.0, 67.0, 66.0, 68.0, 66.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1541.3, "alertThreshold": 2.0}]} 04:36:27 INFO - Return code: 0 04:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:36:27 INFO - # TBPL SUCCESS # 04:36:27 INFO - Running post-action listener: _resource_record_post_action 04:36:27 INFO - ##### 04:36:27 INFO - ##### Finished run-tests step (success) 04:36:27 INFO - ##### 04:36:27 INFO - Running post-run listener: _resource_record_post_run 04:36:27 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535437312; Read time: 12; Write time: 582484 04:36:27 INFO - TinderboxPrint: CPU usage
13.0% 04:36:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:36:27 INFO - TinderboxPrint: I/O write bytes / time
535,437,312 / 582,484 04:36:27 INFO - TinderboxPrint: CPU idle
8,325.1 (87.0%) 04:36:27 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 04:36:27 INFO - TinderboxPrint: Swap in / out
0 / 0 04:36:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253124608; Read time: 0; Write time: 336076 04:36:27 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282312704; Read time: 0; Write time: 246408 04:36:28 INFO - Running post-run listener: _upload_blobber_files 04:36:28 INFO - Blob upload gear active. 04:36:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:28 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 04:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:36:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:32 INFO - (blobuploader) - INFO - Done attempting. 04:36:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:36:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:33 INFO - (blobuploader) - INFO - Done attempting. 04:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:34 INFO - (blobuploader) - INFO - Done attempting. 04:36:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:34 INFO - Return code: 0 04:36:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:36:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4bfcd1b6357db35eb104f15e8e264b12ecb40835866f87df96972dbb7e37d9d8f6b10ce643353ad215ee67e98f13d07d96d3dd8dd70565718f1acd2f4e246ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6b1bfe7f66d266d30d5430ee92a977bf52c187ff11e18b3942198d1f0ccb4d672626f2096601fa877b69be0449465bc8dfe6833466c998ba276ea484e746d30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/328e907bac9537dbed2af55e2268b63b3fb766701fa8fa558cf4a774b65bfb9076310ac465e896c2d5841490e478fe4cfbdded9ae7d1d892e49194e0d417277f"} 04:36:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:36:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:36:34 INFO - Contents: 04:36:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4bfcd1b6357db35eb104f15e8e264b12ecb40835866f87df96972dbb7e37d9d8f6b10ce643353ad215ee67e98f13d07d96d3dd8dd70565718f1acd2f4e246ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6b1bfe7f66d266d30d5430ee92a977bf52c187ff11e18b3942198d1f0ccb4d672626f2096601fa877b69be0449465bc8dfe6833466c998ba276ea484e746d30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/328e907bac9537dbed2af55e2268b63b3fb766701fa8fa558cf4a774b65bfb9076310ac465e896c2d5841490e478fe4cfbdded9ae7d1d892e49194e0d417277f"} 04:36:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:34 INFO - Copying logs to upload dir... 04:36:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:36:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.694467 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 04:36:33.015563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:36:33.018972) ========= 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=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4bfcd1b6357db35eb104f15e8e264b12ecb40835866f87df96972dbb7e37d9d8f6b10ce643353ad215ee67e98f13d07d96d3dd8dd70565718f1acd2f4e246ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6b1bfe7f66d266d30d5430ee92a977bf52c187ff11e18b3942198d1f0ccb4d672626f2096601fa877b69be0449465bc8dfe6833466c998ba276ea484e746d30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/328e907bac9537dbed2af55e2268b63b3fb766701fa8fa558cf4a774b65bfb9076310ac465e896c2d5841490e478fe4cfbdded9ae7d1d892e49194e0d417277f"} build_url:https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/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/Firefox-Non-PGO/sha512/4bfcd1b6357db35eb104f15e8e264b12ecb40835866f87df96972dbb7e37d9d8f6b10ce643353ad215ee67e98f13d07d96d3dd8dd70565718f1acd2f4e246ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6b1bfe7f66d266d30d5430ee92a977bf52c187ff11e18b3942198d1f0ccb4d672626f2096601fa877b69be0449465bc8dfe6833466c998ba276ea484e746d30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/328e907bac9537dbed2af55e2268b63b3fb766701fa8fa558cf4a774b65bfb9076310ac465e896c2d5841490e478fe4cfbdded9ae7d1d892e49194e0d417277f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:36:33.044297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:36:33.044636) ========= 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=52faae308a556c440401f8e5000001e8-1468235739.214668-1627138198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:36:33.127692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:36:33.128010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:36:33.128314) ========= ========= Total master_lag: 0.14 =========