builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1468334040.55 results: success (0) buildid: 20160712065833 builduid: 734ed48d77ae44b08425cbd6933dfcfd revision: f919bd0f63f43dc197d56d04ba70200ca7b4ba37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.550625) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.551400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.551746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.568106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.568441) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 07:34:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-07-12 07:34:00 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.720713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.721068) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019389 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.774195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:00.774554) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f919bd0f63f43dc197d56d04ba70200ca7b4ba37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f919bd0f63f43dc197d56d04ba70200ca7b4ba37 --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=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 07:34:00,970 truncating revision to first 12 chars 2016-07-12 07:34:00,970 Setting DEBUG logging. 2016-07-12 07:34:00,970 attempt 1/10 2016-07-12 07:34:00,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f919bd0f63f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 07:34:01,298 unpacking tar archive at: fx-team-f919bd0f63f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:01.524679) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:01.524958) ========= script_repo_revision: f919bd0f63f43dc197d56d04ba70200ca7b4ba37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:01.525343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:01.525642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 07:34:01.534955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-12 07:34:01.535240) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:34:01 INFO - MultiFileLogger online at 20160712 07:34:01 in /builds/slave/test 07:34:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:34:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:01 INFO - {'append_to_log': False, 07:34:01 INFO - 'base_work_dir': '/builds/slave/test', 07:34:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:34:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:01 INFO - 'branch': 'Fx-Team-Non-PGO', 07:34:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:01 INFO - 'config_files': ('talos/linux_config.py',), 07:34:01 INFO - 'default_actions': ('clobber', 07:34:01 INFO - 'read-buildbot-config', 07:34:01 INFO - 'download-and-extract', 07:34:01 INFO - 'populate-webroot', 07:34:01 INFO - 'create-virtualenv', 07:34:01 INFO - 'install', 07:34:01 INFO - 'run-tests'), 07:34:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:01 INFO - 'download_minidump_stackwalk': True, 07:34:01 INFO - 'download_symbols': 'ondemand', 07:34:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:01 INFO - 'installer_path': 'installer.exe', 07:34:01 INFO - 'log_level': 'info', 07:34:01 INFO - 'log_name': 'talos', 07:34:01 INFO - 'log_to_console': True, 07:34:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:34:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:34:01 INFO - 'opt_config_files': (), 07:34:01 INFO - 'pip_index': False, 07:34:01 INFO - 'sps_profile': False, 07:34:01 INFO - 'sps_profile_interval': 0, 07:34:01 INFO - 'suite': 'dromaeojs', 07:34:01 INFO - 'system_bits': '32', 07:34:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:01 INFO - 'title': 'talos-linux64-ix-055', 07:34:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:01 INFO - 'use_talos_json': True, 07:34:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:01 INFO - 'work_dir': 'build'} 07:34:01 INFO - ##### 07:34:01 INFO - ##### Running clobber step. 07:34:01 INFO - ##### 07:34:01 INFO - Running pre-action listener: _resource_record_pre_action 07:34:01 INFO - Running main action method: clobber 07:34:01 INFO - rmtree: /builds/slave/test/build 07:34:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:02 INFO - Running post-action listener: _resource_record_post_action 07:34:02 INFO - ##### 07:34:02 INFO - ##### Finished clobber step (success) 07:34:02 INFO - ##### 07:34:02 INFO - ##### 07:34:02 INFO - ##### Running read-buildbot-config step. 07:34:02 INFO - ##### 07:34:02 INFO - Running pre-action listener: _resource_record_pre_action 07:34:02 INFO - Running main action method: read_buildbot_config 07:34:02 INFO - Using buildbot properties: 07:34:02 INFO - { 07:34:02 INFO - "project": "", 07:34:02 INFO - "product": "firefox", 07:34:02 INFO - "script_repo_revision": "production", 07:34:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:34:02 INFO - "repository": "", 07:34:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:34:02 INFO - "buildid": "20160712065833", 07:34:02 INFO - "pgo_build": "False", 07:34:02 INFO - "basedir": "/builds/slave/test", 07:34:02 INFO - "buildnumber": 1976, 07:34:02 INFO - "slavename": "talos-linux64-ix-055", 07:34:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:34:02 INFO - "platform": "ubuntu64_hw", 07:34:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:34:02 INFO - "branch": "fx-team", 07:34:02 INFO - "repo_path": "integration/fx-team", 07:34:02 INFO - "revision": "f919bd0f63f43dc197d56d04ba70200ca7b4ba37", 07:34:02 INFO - "stage_platform": "linux64", 07:34:02 INFO - "builduid": "734ed48d77ae44b08425cbd6933dfcfd", 07:34:02 INFO - "slavebuilddir": "test" 07:34:02 INFO - } 07:34:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:34:02 INFO - Running post-action listener: _resource_record_post_action 07:34:02 INFO - ##### 07:34:02 INFO - ##### Finished read-buildbot-config step (success) 07:34:02 INFO - ##### 07:34:02 INFO - ##### 07:34:02 INFO - ##### Running download-and-extract step. 07:34:02 INFO - ##### 07:34:02 INFO - Running pre-action listener: _resource_record_pre_action 07:34:02 INFO - Running main action method: download_and_extract 07:34:02 INFO - mkdir: /builds/slave/test/build/tests 07:34: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')]} 07:34:02 INFO - https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:05 INFO - Downloaded 1361 bytes. 07:34:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:34:06 INFO - Using the following test package requirements: 07:34:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:34:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:34:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'jsshell-linux-x86_64.zip'], 07:34:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:34:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:34:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:34:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:34:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:34:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:34:06 INFO - https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:07 INFO - Downloaded 22750521 bytes. 07:34:07 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'] 07:34:07 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 07:34:09 INFO - Return code: 0 07:34:09 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 07:34:09 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')]} 07:34:09 INFO - https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:12 INFO - Downloaded 22750521 bytes. 07:34:12 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'] 07:34:12 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 07:34:13 INFO - Return code: 0 07:34: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')]} 07:34:13 INFO - https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:34:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:15 INFO - Downloaded 14403317 bytes. 07:34:15 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'] 07:34:15 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 07:34:15 INFO - Return code: 0 07:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:34:15 INFO - https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:34:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:34:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:34:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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 07:34:16 INFO - Downloaded 56666970 bytes. 07:34:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:34:16 INFO - mkdir: /builds/slave/test/properties 07:34:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:16 INFO - Contents: 07:34:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:34:17 INFO - Running post-action listener: _resource_record_post_action 07:34:17 INFO - Running post-action listener: set_extra_try_arguments 07:34:17 INFO - ##### 07:34:17 INFO - ##### Finished download-and-extract step (success) 07:34:17 INFO - ##### 07:34:17 INFO - ##### 07:34:17 INFO - ##### Running populate-webroot step. 07:34:17 INFO - ##### 07:34:17 INFO - Running pre-action listener: _resource_record_pre_action 07:34:17 INFO - Running main action method: populate_webroot 07:34:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:17 INFO - '--tppagecycles', 07:34:17 INFO - '7'], 07:34:17 INFO - 'tests': ['tsvgm']}}, 07:34:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['damp', 'tps']}, 07:34:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'tests': ['damp', 'tps']}, 07:34:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['dromaeo_dom']}, 07:34:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['basic_compositor_video']}, 07:34:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['a11yr', 07:34:17 INFO - 'ts_paint', 07:34:17 INFO - 'tpaint', 07:34:17 INFO - 'sessionrestore', 07:34:17 INFO - 'sessionrestore_no_auto_restore', 07:34:17 INFO - 'tabpaint']}, 07:34:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['tsvgx', 07:34:17 INFO - 'tsvgr_opacity', 07:34:17 INFO - 'tart', 07:34:17 INFO - 'tscrollx', 07:34:17 INFO - 'cart']}, 07:34:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:17 INFO - 'tsvgr_opacity', 07:34:17 INFO - 'tart', 07:34:17 INFO - 'tscrollx', 07:34:17 INFO - 'cart']}, 07:34:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'talos_options': ['--disable-e10s'], 07:34:17 INFO - 'tests': ['tp5o']}, 07:34:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'tests': ['tp5o']}, 07:34:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'talos_options': ['--disable-e10s', 07:34:17 INFO - '--xperf_path', 07:34:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:17 INFO - 'tests': ['tp5n']}, 07:34:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:17 INFO - 'talos_options': ['--xperf_path', 07:34:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:17 INFO - 'tests': ['tp5n']}}, 07:34:17 INFO - 'talos.zip': {'path': '', 07:34:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:17 INFO - Running post-action listener: _resource_record_post_action 07:34:17 INFO - ##### 07:34:17 INFO - ##### Finished populate-webroot step (success) 07:34:17 INFO - ##### 07:34:17 INFO - ##### 07:34:17 INFO - ##### Running create-virtualenv step. 07:34:17 INFO - ##### 07:34:17 INFO - Running pre-action listener: _resource_record_pre_action 07:34:17 INFO - Running main action method: create_virtualenv 07:34:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:17 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 07:34:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:17 INFO - Using real prefix '/usr' 07:34:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:20 INFO - Installing pip.................done. 07:34:20 INFO - Return code: 0 07:34:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:34:20 INFO - Using env: {'DISPLAY': ':0', 07:34:20 INFO - 'HOME': '/home/cltbld', 07:34:20 INFO - 'LANG': 'en_US.UTF-8', 07:34:20 INFO - 'LANGUAGE': 'en_US:en', 07:34:20 INFO - 'LOGNAME': 'cltbld', 07:34:20 INFO - 'MAIL': '/var/mail/cltbld', 07:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:20 INFO - 'MOZ_NO_REMOTE': '1', 07:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:20 INFO - 'NO_EM_RESTART': '1', 07:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:20 INFO - 'PWD': '/builds/slave/test', 07:34:20 INFO - 'SHELL': '/bin/bash', 07:34:20 INFO - 'SHLVL': '1', 07:34:20 INFO - 'TERM': 'linux', 07:34:20 INFO - 'TMOUT': '86400', 07:34:20 INFO - 'USER': 'cltbld', 07:34:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:20 INFO - '_': '/tools/buildbot/bin/python'} 07:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:20 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 07:34:20 INFO - Cleaning up... 07:34:20 INFO - Return code: 0 07:34:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:34:20 INFO - Using env: {'DISPLAY': ':0', 07:34:20 INFO - 'HOME': '/home/cltbld', 07:34:20 INFO - 'LANG': 'en_US.UTF-8', 07:34:20 INFO - 'LANGUAGE': 'en_US:en', 07:34:20 INFO - 'LOGNAME': 'cltbld', 07:34:20 INFO - 'MAIL': '/var/mail/cltbld', 07:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:20 INFO - 'MOZ_NO_REMOTE': '1', 07:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:20 INFO - 'NO_EM_RESTART': '1', 07:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:20 INFO - 'PWD': '/builds/slave/test', 07:34:20 INFO - 'SHELL': '/bin/bash', 07:34:20 INFO - 'SHLVL': '1', 07:34:20 INFO - 'TERM': 'linux', 07:34:20 INFO - 'TMOUT': '86400', 07:34:20 INFO - 'USER': 'cltbld', 07:34:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:20 INFO - '_': '/tools/buildbot/bin/python'} 07:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:20 INFO - Downloading/unpacking psutil>=3.1.1 07:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:22 INFO - Installing collected packages: psutil 07:34:22 INFO - Running setup.py install for psutil 07:34:22 INFO - building 'psutil._psutil_linux' extension 07:34:22 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 07:34:22 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 07:34:23 INFO - building 'psutil._psutil_posix' extension 07:34:23 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 07:34:23 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 07:34:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:23 INFO - Successfully installed psutil 07:34:23 INFO - Cleaning up... 07:34:23 INFO - Return code: 0 07:34:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:23 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:23 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 07:34:23 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 07:34:23 INFO - Using env: {'DISPLAY': ':0', 07:34:23 INFO - 'HOME': '/home/cltbld', 07:34:23 INFO - 'LANG': 'en_US.UTF-8', 07:34:23 INFO - 'LANGUAGE': 'en_US:en', 07:34:23 INFO - 'LOGNAME': 'cltbld', 07:34:23 INFO - 'MAIL': '/var/mail/cltbld', 07:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:23 INFO - 'MOZ_NO_REMOTE': '1', 07:34:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:23 INFO - 'NO_EM_RESTART': '1', 07:34:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:23 INFO - 'PWD': '/builds/slave/test', 07:34:23 INFO - 'SHELL': '/bin/bash', 07:34:23 INFO - 'SHLVL': '1', 07:34:23 INFO - 'TERM': 'linux', 07:34:23 INFO - 'TMOUT': '86400', 07:34:23 INFO - 'USER': 'cltbld', 07:34:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:23 INFO - '_': '/tools/buildbot/bin/python'} 07:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:25 INFO - Installing collected packages: mozsystemmonitor 07:34:25 INFO - Running setup.py install for mozsystemmonitor 07:34:25 INFO - Successfully installed mozsystemmonitor 07:34:25 INFO - Cleaning up... 07:34:25 INFO - Return code: 0 07:34:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:25 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')]} 07:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:25 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')]} 07:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:25 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:25 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 07:34:25 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 07:34:25 INFO - Using env: {'DISPLAY': ':0', 07:34:25 INFO - 'HOME': '/home/cltbld', 07:34:25 INFO - 'LANG': 'en_US.UTF-8', 07:34:25 INFO - 'LANGUAGE': 'en_US:en', 07:34:25 INFO - 'LOGNAME': 'cltbld', 07:34:25 INFO - 'MAIL': '/var/mail/cltbld', 07:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:25 INFO - 'MOZ_NO_REMOTE': '1', 07:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:25 INFO - 'NO_EM_RESTART': '1', 07:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:25 INFO - 'PWD': '/builds/slave/test', 07:34:25 INFO - 'SHELL': '/bin/bash', 07:34:25 INFO - 'SHLVL': '1', 07:34:25 INFO - 'TERM': 'linux', 07:34:25 INFO - 'TMOUT': '86400', 07:34:25 INFO - 'USER': 'cltbld', 07:34:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:25 INFO - '_': '/tools/buildbot/bin/python'} 07:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:34:25 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 07:34:25 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 07:34:25 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 07:34:25 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 07:34:25 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 07:34:25 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 07:34:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:27 INFO - warning: no files found matching '*.txt' 07:34:27 INFO - no previously-included directories found matching 'build' 07:34:27 INFO - no previously-included directories found matching 'dist' 07:34:27 INFO - no previously-included directories found matching '.git*' 07:34:27 INFO - Installing collected packages: jsonschema, functools32 07:34:28 INFO - Running setup.py install for functools32 07:34:28 INFO - warning: no files found matching '*.txt' 07:34:28 INFO - no previously-included directories found matching 'build' 07:34:28 INFO - no previously-included directories found matching 'dist' 07:34:28 INFO - no previously-included directories found matching '.git*' 07:34:28 INFO - Successfully installed jsonschema functools32 07:34:28 INFO - Cleaning up... 07:34:28 INFO - Return code: 0 07:34:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34:28 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')]} 07:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:28 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')]} 07:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:28 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:28 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 07:34:28 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 07:34:28 INFO - Using env: {'DISPLAY': ':0', 07:34:28 INFO - 'HOME': '/home/cltbld', 07:34:28 INFO - 'LANG': 'en_US.UTF-8', 07:34:28 INFO - 'LANGUAGE': 'en_US:en', 07:34:28 INFO - 'LOGNAME': 'cltbld', 07:34:28 INFO - 'MAIL': '/var/mail/cltbld', 07:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:28 INFO - 'MOZ_NO_REMOTE': '1', 07:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:28 INFO - 'NO_EM_RESTART': '1', 07:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:28 INFO - 'PWD': '/builds/slave/test', 07:34:28 INFO - 'SHELL': '/bin/bash', 07:34:28 INFO - 'SHLVL': '1', 07:34:28 INFO - 'TERM': 'linux', 07:34:28 INFO - 'TMOUT': '86400', 07:34:28 INFO - 'USER': 'cltbld', 07:34:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:28 INFO - '_': '/tools/buildbot/bin/python'} 07:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:31 INFO - Downloading docopt-0.6.1.tar.gz 07:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:31 INFO - Running setup.py install for blobuploader 07:34:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:31 INFO - Running setup.py install for requests 07:34:31 INFO - Running setup.py install for docopt 07:34:31 INFO - Successfully installed blobuploader requests docopt 07:34:31 INFO - Cleaning up... 07:34:31 INFO - Return code: 0 07:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:31 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 07:34:31 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 07:34:31 INFO - Using env: {'DISPLAY': ':0', 07:34:31 INFO - 'HOME': '/home/cltbld', 07:34:31 INFO - 'LANG': 'en_US.UTF-8', 07:34:31 INFO - 'LANGUAGE': 'en_US:en', 07:34:31 INFO - 'LOGNAME': 'cltbld', 07:34:31 INFO - 'MAIL': '/var/mail/cltbld', 07:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:31 INFO - 'MOZ_NO_REMOTE': '1', 07:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:31 INFO - 'NO_EM_RESTART': '1', 07:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:31 INFO - 'PWD': '/builds/slave/test', 07:34:31 INFO - 'SHELL': '/bin/bash', 07:34:31 INFO - 'SHLVL': '1', 07:34:31 INFO - 'TERM': 'linux', 07:34:31 INFO - 'TMOUT': '86400', 07:34:31 INFO - 'USER': 'cltbld', 07:34:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:31 INFO - '_': '/tools/buildbot/bin/python'} 07:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:32 INFO - Running setup.py (path:/tmp/pip-JJdkBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:32 INFO - Running setup.py (path:/tmp/pip-ED8l0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:32 INFO - Running setup.py (path:/tmp/pip-2PIvHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:32 INFO - Running setup.py (path:/tmp/pip-jyoH2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:32 INFO - Running setup.py (path:/tmp/pip-DGrdI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:32 INFO - Running setup.py (path:/tmp/pip-k7q4JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:32 INFO - Running setup.py (path:/tmp/pip-Wd0N31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:32 INFO - Running setup.py (path:/tmp/pip-1CL1i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:32 INFO - Running setup.py (path:/tmp/pip-Fj3XqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:32 INFO - Running setup.py (path:/tmp/pip-_Mm8Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 INFO - Running setup.py (path:/tmp/pip-ikAJKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:32 INFO - Running setup.py (path:/tmp/pip-7od2Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:32 INFO - Running setup.py (path:/tmp/pip-Gk8Z81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:33 INFO - Running setup.py (path:/tmp/pip-RTVGmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:33 INFO - Running setup.py (path:/tmp/pip-HpUMzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:33 INFO - Running setup.py (path:/tmp/pip-BJP_5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:33 INFO - Running setup.py (path:/tmp/pip-qdv_qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:33 INFO - Running setup.py install for manifestparser 07:34:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Running setup.py install for mozcrash 07:34:33 INFO - Running setup.py install for mozdebug 07:34:33 INFO - Running setup.py install for mozdevice 07:34:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Running setup.py install for mozfile 07:34:33 INFO - Running setup.py install for mozhttpd 07:34:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Running setup.py install for mozinfo 07:34:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Running setup.py install for mozInstall 07:34:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozleak 07:34:34 INFO - Running setup.py install for mozlog 07:34:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for moznetwork 07:34:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozprocess 07:34:34 INFO - Running setup.py install for mozprofile 07:34:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozrunner 07:34:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozscreenshot 07:34:34 INFO - Running setup.py install for moztest 07:34:34 INFO - Running setup.py install for mozversion 07:34:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:35 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')]} 07:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 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')]} 07:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:35 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 07:34:35 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 07:34:35 INFO - Using env: {'DISPLAY': ':0', 07:34:35 INFO - 'HOME': '/home/cltbld', 07:34:35 INFO - 'LANG': 'en_US.UTF-8', 07:34:35 INFO - 'LANGUAGE': 'en_US:en', 07:34:35 INFO - 'LOGNAME': 'cltbld', 07:34:35 INFO - 'MAIL': '/var/mail/cltbld', 07:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:35 INFO - 'MOZ_NO_REMOTE': '1', 07:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:35 INFO - 'NO_EM_RESTART': '1', 07:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:35 INFO - 'PWD': '/builds/slave/test', 07:34:35 INFO - 'SHELL': '/bin/bash', 07:34:35 INFO - 'SHLVL': '1', 07:34:35 INFO - 'TERM': 'linux', 07:34:35 INFO - 'TMOUT': '86400', 07:34:35 INFO - 'USER': 'cltbld', 07:34:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:35 INFO - '_': '/tools/buildbot/bin/python'} 07:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:35 INFO - Running setup.py (path:/tmp/pip-MtKQxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:35 INFO - Running setup.py (path:/tmp/pip-YvFuHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:35 INFO - Running setup.py (path:/tmp/pip-lR8eNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:35 INFO - Running setup.py (path:/tmp/pip-yvQS5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:35 INFO - Running setup.py (path:/tmp/pip-Ylb3b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:35 INFO - Running setup.py (path:/tmp/pip-o6HLs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:35 INFO - Running setup.py (path:/tmp/pip-3SvJGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:35 INFO - Running setup.py (path:/tmp/pip-DuOMcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:35 INFO - Running setup.py (path:/tmp/pip-eRN_Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:35 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)) 07:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:35 INFO - Running setup.py (path:/tmp/pip-9ZpD5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:36 INFO - Running setup.py (path:/tmp/pip-XI7CTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:36 INFO - Running setup.py (path:/tmp/pip-SARdPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:36 INFO - Running setup.py (path:/tmp/pip-o39WRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:36 INFO - Running setup.py (path:/tmp/pip-HQZg5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:36 INFO - Running setup.py (path:/tmp/pip-dojYg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:36 INFO - Running setup.py (path:/tmp/pip-1Itvl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:36 INFO - Running setup.py (path:/tmp/pip-Greq3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:38 INFO - Downloading blessings-1.6.tar.gz 07:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:38 INFO - Installing collected packages: blessings 07:34:38 INFO - Running setup.py install for blessings 07:34:38 INFO - Successfully installed blessings 07:34:38 INFO - Cleaning up... 07:34:38 INFO - Return code: 0 07:34:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:38 INFO - Reading from file tmpfile_stdout 07:34:38 INFO - Current package versions: 07:34:38 INFO - argparse == 1.2.1 07:34:38 INFO - blessings == 1.6 07:34:38 INFO - blobuploader == 1.2.4 07:34:38 INFO - docopt == 0.6.1 07:34:38 INFO - functools32 == 3.2.3-2 07:34:38 INFO - jsonschema == 2.5.1 07:34:38 INFO - manifestparser == 1.1 07:34:38 INFO - mozInstall == 1.12 07:34:38 INFO - mozcrash == 0.17 07:34:38 INFO - mozdebug == 0.1 07:34:38 INFO - mozdevice == 0.48 07:34:38 INFO - mozfile == 1.2 07:34:38 INFO - mozhttpd == 0.7 07:34:38 INFO - mozinfo == 0.9 07:34:38 INFO - mozleak == 0.1 07:34:38 INFO - mozlog == 3.2 07:34:38 INFO - moznetwork == 0.27 07:34:38 INFO - mozprocess == 0.23 07:34:38 INFO - mozprofile == 0.28 07:34:38 INFO - mozrunner == 6.12 07:34:38 INFO - mozscreenshot == 0.1 07:34:38 INFO - mozsystemmonitor == 0.3 07:34:38 INFO - moztest == 0.7 07:34:38 INFO - mozversion == 1.4 07:34:38 INFO - psutil == 3.1.1 07:34:38 INFO - requests == 1.2.3 07:34:38 INFO - wsgiref == 0.1.2 07:34:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:38 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')]} 07:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:38 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')]} 07:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:38 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:38 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 07:34:38 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 07:34:38 INFO - Using env: {'DISPLAY': ':0', 07:34:38 INFO - 'HOME': '/home/cltbld', 07:34:38 INFO - 'LANG': 'en_US.UTF-8', 07:34:38 INFO - 'LANGUAGE': 'en_US:en', 07:34:38 INFO - 'LOGNAME': 'cltbld', 07:34:38 INFO - 'MAIL': '/var/mail/cltbld', 07:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:38 INFO - 'MOZ_NO_REMOTE': '1', 07:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:38 INFO - 'NO_EM_RESTART': '1', 07:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:38 INFO - 'PWD': '/builds/slave/test', 07:34:38 INFO - 'SHELL': '/bin/bash', 07:34:38 INFO - 'SHLVL': '1', 07:34:38 INFO - 'TERM': 'linux', 07:34:38 INFO - 'TMOUT': '86400', 07:34:38 INFO - 'USER': 'cltbld', 07:34:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:38 INFO - '_': '/tools/buildbot/bin/python'} 07:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 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)) 07:34:39 INFO - Cleaning up... 07:34:39 INFO - Return code: 0 07:34:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:39 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 0x18f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', '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 07:34:39 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 07:34:39 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 07:34:39 INFO - Using env: {'DISPLAY': ':0', 07:34:39 INFO - 'HOME': '/home/cltbld', 07:34:39 INFO - 'LANG': 'en_US.UTF-8', 07:34:39 INFO - 'LANGUAGE': 'en_US:en', 07:34:39 INFO - 'LOGNAME': 'cltbld', 07:34:39 INFO - 'MAIL': '/var/mail/cltbld', 07:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:39 INFO - 'MOZ_NO_REMOTE': '1', 07:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:39 INFO - 'NO_EM_RESTART': '1', 07:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:39 INFO - 'PWD': '/builds/slave/test', 07:34:39 INFO - 'SHELL': '/bin/bash', 07:34:39 INFO - 'SHLVL': '1', 07:34:39 INFO - 'TERM': 'linux', 07:34:39 INFO - 'TMOUT': '86400', 07:34:39 INFO - 'USER': 'cltbld', 07:34:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:39 INFO - '_': '/tools/buildbot/bin/python'} 07:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:39 INFO - Cleaning up... 07:34:39 INFO - Return code: 0 07:34:39 INFO - Running post-action listener: _resource_record_post_action 07:34:39 INFO - Running post-action listener: _start_resource_monitoring 07:34:39 INFO - Starting resource monitoring. 07:34:39 INFO - ##### 07:34:39 INFO - ##### Finished create-virtualenv step (success) 07:34:39 INFO - ##### 07:34:39 INFO - ##### 07:34:39 INFO - ##### Running install step. 07:34:39 INFO - ##### 07:34:39 INFO - Running pre-action listener: _resource_record_pre_action 07:34:39 INFO - Running main action method: install 07:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:39 INFO - Reading from file tmpfile_stdout 07:34:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:39 INFO - Reading from file tmpfile_stdout 07:34:39 INFO - Output received: 07:34:39 INFO - Usage: mozinstall [options] installer 07:34:39 INFO - Options: 07:34:39 INFO - -h, --help show this help message and exit 07:34:39 INFO - -d DEST, --destination=DEST 07:34:39 INFO - Directory to install application into. [default: 07:34:39 INFO - "/builds/slave/test"] 07:34:39 INFO - --app=APP Application being installed. [default: firefox] 07:34:39 INFO - mkdir: /builds/slave/test/build/application 07:34:39 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'] 07:34:39 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 07:34:55 INFO - Reading from file tmpfile_stdout 07:34:55 INFO - Output received: 07:34:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:34:55 INFO - Running post-action listener: _resource_record_post_action 07:34:55 INFO - ##### 07:34:55 INFO - ##### Finished install step (success) 07:34:55 INFO - ##### 07:34:55 INFO - ##### 07:34:55 INFO - ##### Running run-tests step. 07:34:55 INFO - ##### 07:34:55 INFO - Running pre-action listener: _resource_record_pre_action 07:34:55 INFO - Running main action method: run_tests 07:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:34:55 INFO - Python 2.7.3 07:34:55 INFO - Return code: 0 07:34:55 INFO - grabbing minidump binary from tooltool 07:34: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')]} 07:34:55 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 0x1bb63b0>, '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 0x1bb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:34:55 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 07:34:55 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 07:34:55 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 07:34:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:34:56 INFO - Return code: 0 07:34:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:34:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:34:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:34:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:34:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 07:34:56 INFO - Using env: {'DISPLAY': ':0', 07:34:56 INFO - 'HOME': '/home/cltbld', 07:34:56 INFO - 'LANG': 'en_US.UTF-8', 07:34:56 INFO - 'LANGUAGE': 'en_US:en', 07:34:56 INFO - 'LOGNAME': 'cltbld', 07:34:56 INFO - 'MAIL': '/var/mail/cltbld', 07:34:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:34:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:56 INFO - 'MOZ_NO_REMOTE': '1', 07:34:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:56 INFO - 'NO_EM_RESTART': '1', 07:34:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:56 INFO - 'PWD': '/builds/slave/test', 07:34:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:34:56 INFO - 'SHELL': '/bin/bash', 07:34:56 INFO - 'SHLVL': '1', 07:34:56 INFO - 'TERM': 'linux', 07:34:56 INFO - 'TMOUT': '86400', 07:34:56 INFO - 'USER': 'cltbld', 07:34:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828', 07:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:56 INFO - '_': '/tools/buildbot/bin/python'} 07:34:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:34:56 INFO - mozversion application_buildid: 20160712065833 07:34:56 INFO - mozversion application_changeset: f919bd0f63f43dc197d56d04ba70200ca7b4ba37 07:34:56 INFO - mozversion application_display_name: Nightly 07:34:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:34:56 INFO - mozversion application_name: Firefox 07:34:56 INFO - mozversion application_remotingname: firefox 07:34:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:34:56 INFO - mozversion application_vendor: Mozilla 07:34:56 INFO - mozversion application_version: 50.0a1 07:34:56 INFO - mozversion platform_buildid: 20160712065833 07:34:56 INFO - mozversion platform_changeset: f919bd0f63f43dc197d56d04ba70200ca7b4ba37 07:34:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:34:56 INFO - mozversion platform_version: 50.0a1 07:34:56 INFO - using testdate: 1468334096 07:34:56 INFO - actual date: 1468334096 07:34:56 INFO - starting webserver on 'localhost:41961' 07:34:56 INFO - SUITE-START | Running 2 tests 07:34:56 INFO - TEST-START | dromaeo_css 07:34:56 INFO - operating with platform_type : linux_ 07:34:56 INFO - Initialising browser for dromaeo_css test... 07:34:56 INFO - TEST-INFO | started process 15940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNxYAsS/profile http://localhost:41961/getInfo.html) 07:35:00 INFO - PROCESS | 15940 | __metrics Screen width/height:1600/1200 07:35:00 INFO - PROCESS | 15940 | colorDepth:24 07:35:00 INFO - PROCESS | 15940 | Browser inner width/height: 1024/697 07:35:00 INFO - PROCESS | 15940 | __metrics 07:35:01 INFO - PROCESS | 15940 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:01 INFO - PROCESS | 15940 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:02 INFO - TEST-INFO | 15940: exit 0 07:35:02 INFO - Browser initialized. 07:35:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:02 INFO - TEST-INFO | started process 16023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNxYAsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:14 INFO - PROCESS | 16023 | RSS: Main: 158875648 07:35:14 INFO - PROCESS | 16023 | 07:36:06 INFO - PROCESS | 16023 | 1468334166047 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] 07:38:17 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41961/tests/dromaeo/cssquery-ext.html) 07:38:18 INFO - PROCESS | 16023 | RSS: Main: 266412032 07:38:18 INFO - PROCESS | 16023 | 07:41:21 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-ext.html (next: http://localhost:41961/tests/dromaeo/cssquery-jquery.html) 07:41:22 INFO - PROCESS | 16023 | RSS: Main: 241209344 07:41:22 INFO - PROCESS | 16023 | 07:44:24 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41961/tests/dromaeo/cssquery-mootools.html) 07:44:25 INFO - PROCESS | 16023 | RSS: Main: 236982272 07:44:25 INFO - PROCESS | 16023 | 07:47:27 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41961/tests/dromaeo/cssquery-prototype.html) 07:47:27 INFO - PROCESS | 16023 | RSS: Main: 241766400 07:47:27 INFO - PROCESS | 16023 | 07:50:30 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41961/tests/dromaeo/cssquery-yui.html) 07:50:31 INFO - PROCESS | 16023 | RSS: Main: 221478912 07:50:31 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-yui.html (next: http://localhost:41961/tests/dromaeo/cssquery-dojo.html) 07:53:34 INFO - PROCESS | 16023 | RSS: Main: 281829376 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | __start_tp_report 07:53:34 INFO - PROCESS | 16023 | _x_x_mozilla_page_load 07:53:34 INFO - PROCESS | 16023 | _x_x_mozilla_page_load_details 07:53:34 INFO - PROCESS | 16023 | |i|pagename|runs| 07:53:34 INFO - PROCESS | 16023 | |0;dojo.html;2581.186926118273;2590.572555528338;2620.384209710718;2631.263246291037;2633.4206474575585;4565.223911934971;4611.077784443112;4617.445906491222;4633.9073218535605;4648.047150334181;4656.557627025436;4656.743879086657;4689.179393606114;4704.153252414564;4707.552782485658;4325.32957391604;4325.978370108145;4347.065380943112;4357.738535687853;4455.019895622958;4317.417148684919;4386.363977223301;4396.406485124515;4423.203823311803;4429.269170586849;4213.431186789775;4324.17840610283;4363.80362883671;4385.407969924067;4391.407160033386;4208.494980602317;4212.431321771553;4247.108107297471;4314.482262128565;4317.287647538184;4200.558941311179;4255.97872010638;4261.126469073833;4266.424032755569;4320.027993701424;4578.656600754956;4625.306204069383;4647.930281045787;4703.388559487279;4716.033213191287;4958.628102892261;4980.078685443204;4992.975035124838;5065.493450654942;5065.772040258197;5047.49525047496;5066.544011038987;5083.262926875583;5088.6692364996525;5116.6674166179455;4574.794134263966;4691.179043667345;4705.082508910764;4712.882177945578;4715.575598196178;5147.6654017488745;5159.1487404578575;5235.110031294689;5236.319278493771;5250.973745131327;4962.082014827269;4972.7513624318635;4986.551210391082;5026.748662566857;5030.119729047402;4863.1732605457155;4897.926531102036;4936.580390666762;5061.063703214917;5107.310513080686;4936;4946.233333833262;4957.578605818474;4961.107000739829;5009.599232061426;4925.16272233714;4930.8767280818265;4931.506849315111;4955.256711493233;4985.925211121836;4094.385842123705;4115.42384066231;4124.4019617155345;4193.308104162779;4242.406063151161;3634.1459756957092;3637.9818100909324;3682.963170368316;3693.4644476550748;3720.404735242348;4284.057507348379;4291.935620965688;4295.398644189816;4297.119090586422;4327.956720432819;4875.366202393737;4923.679960802537;4966.875828104254;4974.403071631355;5009.89980200394;4318.395424640553;4321.984333681582;4349.9130017399475;4356.063446359048;4366.476022877211;4504.211762941472;4504.34686970394;4504.819807207675;4539.818407263739;4566.0411313623845;4573.748443835488;4639.582437580634;4742.170120229015;4745.050989802123;4746.620270378361;4921.384826896638;4924.335214745964;4959.925601116059;4970.602351811919;5023.648344615842;4658.58072773452;4668.137753204653;4676.602488788491;4680;4722.716637001791;4813.975930120327;4900.14247506692;4915;4922.064807686528;4967.031428871335;4966.900661986812;4990.575801056805;4992.975035124801;5007.173816320266;5027.7737501813235;4860.270959356125;4867.29424233477;4869.756512174448;4877.756112194447;4900.730459824744;4770.308305295782;4860.562549370574;4861.149298872754;4912.901741965212;4916.729579873141;4782.306565548046;4785.904281914272;4812.133815913169;4817.494163112823;4877.487863774252;4935.802567897387;4937.580305674058;4940.456549779449;4941.234108713155;4971.627127965345;4697.060587882369;4748.786304616369;4790.377250957354;4791.688540244873;4834.395700537433 07:53:34 INFO - PROCESS | 16023 | |1;ext.html;563.7237753500785;570.4039278953493;576.0926540698401;579.7709904587688;582.9387914269001;27005.729942700567;39919.60080399199;41027.589724102785;41065.38401923966;44267.33598996018;41739.79130104345;42374.36438453426;42432.78783606085;42456.36315455263;42459.575404245945;7859.292663660255;7993.800154996143;7993.840123197532;7998.080220774598;7999.760007199793;7926.960365198195;8002.63988120533;8011.599420029004;8025.478343907656;8025.959870200641;8037.477563958353;8062.19378062192;8081.111077781439;8081.111077781439;8083.95958020209;8004.679812807481;8027.036755589366;8035.633942229835;8039.598020099001;8042.638081286298;7885.290323870821;7946.245106714853;7950.24472675095;7954.602269886483;7958.6418611162635;39146.21707565861;39454;39464.40803387952;39531.8023409884;39620;2399.3761621978238;2422.5760491913843;2434.9773095300015;2504.724480307165;2633.644457998165;29129.85435072811;29685.703142968727;29825.25436864074;29993.46353444516;31020;3499.9650003500146;3529.6293889141784;3568.107973006748;3568.6431356864364;3598.6941110005682;190096;190608;190922;191100;191378.5172889631;31790.523142152888;53691.19463208055;54031;54039.18941215885;54346.45653543414;32631;33749.83125084359;33778.32443351168;33786.662133378355;33842.32315353679;13023.609291721263;13132.671683207996;13132.737345253232;13134;13141.868581314257;11139;11208.66374008781;11208.831867521994;11218.831717524243;11231.71920701989;7919.247671471201;7928.4450088494405;7949.284564389232;7971.920280797234;8015;3093.3040065985424;3103.7672174586996;3121.562981182636;3129.0925631567047;3191.3776813521604;883.8099808541194;905.515549181185;932.2495391210141;988.313122379939;1004.7488127968008;26737.19788406351;27579.586306205423;27782;28603.85698071496;28768;908.3596064774318;927.5872236854535;978.4911845840123;982.1602529837029;1015.8933312002133;14403;14950;15003.549893503212;15240.085594864344;15362.308696108701;401844;403662;406508;406656;408490;50467;50928.23607645888;51116.23325650118;51208;51215.743921280155;1016.9745756356002;1078.309881675728;1175.9176857620055;1221.73732647483;1224.8407706998212;27399.86300068487;28570.857145714137;28797.512646711588;29098.854505727337;29429.11712648624;37027.629723703496;46991;48126;48156.759216203696;52804;380407;383973;385271;385481;385698;31431.842840785648;37135;37799.43300850435;38625.2274954505;38713.612863871;41440;42642.5735742651;42840.57159428366;42909.356359654004;43576.78211608922;36685.449718253716;36781.816090919376;36831.63168368282;37545.4368184472;37619.43570846385;36088.81955590205;36095.45856812097;36771.08072298107;36844;37262.44106338353;36144;36854.26291474209;36902.630973691;37203.6279637211;37272.81363593273;31634.367312654078;32678.673213267564;32870;33385.499217512246;33482.33035339231;24917.626235606844;25259.368515787253;25269.74730252674;25835.741642584086;26034 07:53:34 INFO - PROCESS | 16023 | |2;jquery.html;346.14674826552545;361.50654356802954;366.76160495677806;375.34689640026346;377.38863041872156;13166.473341066347;16491.340346386147;17110.486685399428;18426.170822312994;18447.44657660269;16905.91547042266;17606.20772065257;17657.381991630296;17666.82333176671;17696.557586060357;4906.190478571031;5138.280640710285;5153.613478989072;5154.355705536808;5156.200788877712;3668.8715894943684;5110.463401342861;5881.823545293648;6236.781712640059;6246.843828904268;6084.026555751081;6178.876422471548;6191.969040154793;6196.473299769525;6206.596571222856;6001.519878409738;6162.1681073055015;6171.475424588915;6177.876442471171;6183.536234782387;3325.8503367348526;5033.521815427529;5331.5201631853315;5409.783608655649;5410.729463526847;21358.252461163785;21710.78289217119;21967.560648786934;21991.780082199133;22044.11823527057;1826.0778306954903;1841.3555255660547;2033.3391647714552;2063.0133310808496;2103.95792084159;13330.333483325892;13394.129381590166;13576.728465430735;13707.314634268347;14051.367688454044;1731.047923641992;1813.2928158018383;1902.5053486093577;1904.5905130396893;1923.692209246528;70116.6494167531;70596;72733.27266727318;73927.99999999946;74723;9042.321825862955;9379.98330358976;10370.896291036994;10420.166386689047;10429.739256518647;13748.518801841887;14144.787828182585;14322.928385358007;14327.78508322376;14345.282735863373;7153.4992550520965;7206.891896621555;7263.92491535158;7266.055412796409;7383.2247614000835;6885.311468853075;6976.162860456778;6984.720611175598;7118.003479512872;7119.71521139159;4382.649388048949;4430.645548356124;4447.710898791633;4452.4211852458975;4520.118576877478;1763.206557049333;1881.1910878322453;1887.5564242403025;1888.3957133717354;1902.4958386027713;783.764870538836;837.3970741066422;881.8412685716504;888.4225253585092;893.9808618175285;17294.221760020577;17441.389551365894;17641.7353739694;17850.5537361567;18095.185716642784;836.188896770132;860.1871231686122;870.2776695342977;870.4037734152126;874.580201503282;8123.530053885718;9911.15755160805;9925.305228633926;9928.106470417697;9963.800723985625;389485;395384;396515;397574;399814;75574;78848;79349.60325198337;79581;80108;840.8318336332758;861.3410740783306;862.9741107766652;867.5748883047388;870.5342641686793;15421.922890385926;15623.218839058229;15804.36782528686;15959;16221.59446013859;28131.859340703166;34876.30247394987;35338.646613533536;38208.23583528258;39311;48208.758956205;48716.512834871195;48809;48916;49426.75286623544;7172.282771722995;7277.490575659653;7302.963485182752;7407.1852096268285;7528.360089392463;10853.728656783644;11268.830967535658;11571.826422603499;11821.986077681126;11895.226810257305;10007.249456290952;10034.749131271778;10337.328073675188;10384.065434110966;10728.570857165625;10150.644727434505;10451.895481045092;10656.254062215881;10739.194560407845;11226.831597526207;10726.892731072589;10888.292261003326;10894.291871028357;11112.444377781241;11183;6225.750969961332;7820.413468989735;7917.406194535548;8035.397345199017;8087.47431416956;9897.950510247403;10349.689509314732;10351.275410721177;10411.531481083219;10472.214583906085 07:53:34 INFO - PROCESS | 16023 | |3;mootools.html;1366.0847232354317;1407.8803301719354;1497.4534294982327;1687.3419366447088;1696.3384280130742;6961.199462061864;7323.157836848764;7400.407967362611;7405.333519983201;7410.555366678003;6323.77866774663;6519.445847103002;7033.085698859154;7242.022326985855;7248.311410416015;2208.3595757230382;2243.7644047375034;2245.764194759543;2248.2917880867476;2249.898754556049;1895.9526011849746;2199.3511913985412;2227.2984010036785;2229.487217939875;2232.6427771556555;2116.5449428372895;2197.8241740660787;2198.043850924853;2205.647096464566;2206.3932418584936;2184.4866456382897;2196.769339219375;2202.1631779923605;2206.2609025976317;2211.7677643847323;2176.869387836735;2179.2372669565684;2179.498715295475;2183.2140429445385;2185.5628874225217;7475.140358858746;7521.097468303784;7524.887126693104;7533.886991695129;7538.246175382473;4239.915201695949;4334.393184954109;4350.782460876975;4465.218586747339;4532.184206842767;2900.2894290898653;2996;3028.530577760451;3035.696430356969;3048.557959095941;938.2072149034055;947.1806887042727;958.6788425877339;961.1445813226235;965.5896244096231;9833.31166818323;9835.96722344158;9867.555959981819;9906.257030722652;10000.149987251092;4047.9797601012397;4077.4495443115393;4253.298205796071;4258.978705106455;4261.680373971964;8374.53940033304;8420.242178203991;8437.957810211032;8451.36614753896;8470.745877623682;4602.700824446467;4610.815567377267;4613.861584152481;4619.86140415788;4621.237495813153;4139.8965025874595;4207.894802629898;4223.366495025709;4233.470816147981;4238.300680387763;3557.4130268505924;3564.8574057037426;3594.2092739597247;3667.651573100551;3677.9816100919325;1037.1339931157568;1130.949107290174;1142.651491295163;1144.3534403062242;1186.7033241689578;804.9315808156255;814.6578437056451;839.2711015308362;857.6269322844582;857.8756080368437;5021.121303771825;5110.7955681773055;5145.279660847485;5211.166213405837;5225.947740522623;849.1169184048644;850.2093053460218;873.4148120759106;912.6395073945754;916.9213670464007;3473.4442489201606;3493.528373669573;3531.5938667053106;3562.59030211529;3567.090391950036;8780.912190878009;9052.411593246417;9125.863112053325;9149.313801464918;9172.495512746864;7918.366530677532;8540.14598540141;8893.777655558662;8902.554872256362;9074.818503629891;6988.720451181997;7063.505554611231;7115.75094871677;7123.465740069516;7137.785866424016;5226.451222621722;5340.652857564246;5353.919691204557;5385.919211211756;5414.35027796667;8358.791030224293;8545.871811922701;8552.743417697478;8699.260562852229;8710.69512567057;8578.485290882567;8789.648414063366;8796.340274479568;8858.601362938554;8859.512726800089;6194.349593292639;6277.811665650038;6302.968485157545;6335.954567496311;6338.809835704937;6710.194776626836;6922.653867306513;6959.756408525677;7020.0522929405915;7067.5052746307265;4819.855404337875;6463;6519.08732777402;6561.40947314744;6732.124823772878;6329.113924050729;6424.9036264455135;6457.225132983884;6476.190476190476;6533.771318003847;6082.513398928164;6093.451589356979;6097.2683278006925;6116.633002019893;6117.938820611737;4391.890202744957;4536.183486972244;4547.704399214041;4595.563421474954;4697.976510117427;4469.190127669734;4483.843065492692;4502.302143167814;4552.271636538138;4581.74800385982 07:53:34 INFO - PROCESS | 16023 | |4;prototype.html;290.29458416048993;294.6096422240531;299.9640043194816;302.51748461204386;305.7798385162682;4780.2590598457255;4819.5662390384905;4838.298446725223;4848.951510484899;4872.805087796484;4488.1696886076015;4636.2581986882105;4652.185867473196;4663.953360466395;4779.856604301876;3614.114541937216;3690.7970061646597;3705.12929461577;3733.4213196954515;3751.962480375202;3728.8694895678655;3752.6810221131236;3768.8492460301554;3770.189409277005;3800.5059342285463;3615.313090512794;3721.62783721627;3730.850765969358;3737.5514938207452;3747.3067482515685;3697.4638677391895;3708.8145592720525;3734.477173195755;3736.9626303737023;3748.6063963283736;3271.607407111138;3278.2623909620384;3278.9016329510155;3279.8360081995806;3285.6878596533293;4703.412073490814;4704.623630109583;4704.95295047052;4707.917179048838;4712.670113092085;4159.459270294872;4274.123804620045;4304.332828411601;4319.157764235975;4347.456567929009;4980.452150263468;4990.975045124787;5006.173981293082;5015.1975683890405;5020.272060551236;3622.1487950331652;3624.0939765058733;3625.23869987303;3641.4901913732097;3657.3965295726175;4969.235921247977;5275.762590683428;5308.601854860863;5324.896665817019;5329.2006199070065;3647.6170002149925;3653.6981701527866;3660.6888414484533;3664.102294937704;3673.145061743802;3711.406175011985;3713.7400381973002;3723.515942927402;3727.552693676722;3732.458793474931;4279.667581168271;4289.399484072233;4290.399344091829;4291.098869237433;4293.248681480791;4835.685680430761;5007.474215207423;5023.773930173151;5048.7728052237735;5106.131957567222;1277.5975567696146;1287.1183239480986;1300.7528569571941;1301.3883474766844;1304.6803533134253;834.6145398638231;867.9435836670597;890.4479222881855;898.9775255618531;901.9278457723366;4399.274119770202;4401.449818772653;4411.4926783420315;4416.31547110192;4421.9336709949375;5082.593392528663;5105.26868125551;5109.3139264042775;5136.897262054738;5149.588032957355;4319.287317592625;4361.629261512743;4399.274119770266;4411.9043454358925;4435.955640443619;2686.449277898026;2700.9729902701115;2701.91894243173;2707.837529748221;2709.5749304372475;4818.494058123846;4827.710337379768;4832.081904438145;4836.782344794493;4846.733429661403;4969.254611808257;5201.867234433864;5203.791848326025;5232.927249913759;5240.187770895517;4799.66402351839;4805.639577031737;4830.3237546743485;4839.782209800567;4846.273059041031;5072.28987941681;5086.669366491166;5088.48120180513;5102;5106.948930510796;4864.513548645107;4960.7767650456535;5030.144875371123;5119.92320115206;5166.4316925137455;4873.561379475864;4911.189653707098;4915.459299476983;4919.770057485629;4935.901281974268;3724.888253352404;3725.590185079693;3746.8313925873945;3747.7376583638884;3747.981260093682;5138.409082955508;5217.843464696065;5235.214717792362;5277.683338999673;5281.973590132025;5037.244413338029;5053.519915608012;5054.19132938728;5066.746662666926;5090.796368145381;5009.4489606144025;5039.748012599429;5044.596432285335;5047.949520504748;5076;4780.593649539828;4861.829835955725;5002.2496625506465;5005.749712514433;5046.419661738947;4982.6297768114055;5079.415867175322;5096.51583099605;5102.821401250939;5117.462666420121;4956.306117143675;4994.500549944976;5018.623603229699;5029.06962211992;5031.270465782368 07:53:34 INFO - PROCESS | 16023 | |5;yui.html;636.4780879678664;663.7544108679789;687.4809518813295;734.7795661301611;747.7009196321472;12181.45183466744;13016.219026858384;13021.60935171944;13065.608031759039;14898.180600066991;14149.36327865246;14223.857761422383;14224.217668028281;14238.644033899158;14242.928785356085;628.6196850905205;789.8538770327493;808.9919100808976;813.8738495533172;814.0028465130227;771.090113665874;798.7763426240633;805.3677862877643;806.8426656801926;807.0638059850575;835.4360806455649;839.4837175137277;840.2185967050641;841.7264389073545;842.4860834890711;654.3489228217906;802.6869520886859;833.7040350675513;834.1825011488775;834.6869923778584;605.2162449627699;605.9818205453844;608.7747533412621;608.9238845144357;608.984775380619;13003.869961300361;13033.283169425678;13058.738825223538;13074.542391016268;13105.410256538478;11921.225120367235;12347.938260308641;12440.564580239648;12534.24794512323;12593.433295501725;12072.758544829054;12234.327112008836;12298.631041068782;12387.75224495505;12675.492980280778;4186.1418409226035;4254.595813397722;4334.631556317717;4417.845375411877;4427.579379958899;50516.24225636618;50660;51160.74419627878;68142.65928670374;68169.3183068173;9138.680146194984;9324.25405967521;9464.148226659496;9536.2371010319;9546.665866694633;18260;18617.90691046536;18648.533786655444;18685.81314186868;18692.719609205873;6650.235222949326;6726.529142960044;6738.393544581011;6755.121834161528;7029.191642961023;3677.595464498903;3780.4140358244517;3780.8676696316047;3795;3845.2309538092495;2738.137486691686;2819.196528989269;2851.21591562322;2853.215365774429;2853.814502057401;473.54066555441165;476.014649675176;477.95459431353964;478.82448588714624;479.63547703745405;463.60130287952336;474.5728844040322;529.4625954656027;543.5868739757813;570.1732487892573;7543.207963163899;7709.190534993857;7749.418793590503;7767.805804854811;7896;486.85881094482914;503.65247978894445;547.8274343581759;604.6734763227807;649.3960616626582;4047.4738284022887;4074.7758873262255;4155.625993660585;4213.747175169499;4265.0830071534765;25750.871245644026;25753.227403177934;25784.61323080155;25789.484210316063;27527.724722752915;82582;83500.0774972873;84524;85292.14707852842;85491;61792.073118904154;69942.30057699358;76364.61817690876;77218.6139069301;78045;8544.74365769028;8822;8886.60010299551;9044.864327034968;9138.862917056116;40037;41606.79196603998;43534.3879367239;46212.53787462082;46484.7675761619;57040.71479642575;63426.36573634389;63470.68264658647;63651;65371.34628653653;10523.94738026305;10915.945420272848;11020.614278500214;11258.887411126112;11267.830982535104;12359.567415140427;12468.875311247135;13102.672433189247;13611.659708507366;14066.859331406964;7466.962665186639;11918.940405297919;11953.581624643095;12617.810732839198;13213.735725285633;12053.51785928553;12127.393630318273;12199.146059776085;12529.624111276677;12600.873991260336;11508.712282193012;11544.19190656646;11619.76760464769;11669;11836.822447663464;9315.441073535609;9464.668736594185;9520.714378568655;9755.60977560918;9788.657396991071;9757.853632195665;9982.750431238986;9989.700308990741;10095.242856785624;10125.64560240388 07:53:34 INFO - PROCESS | 16023 | __end_tp_report 07:53:34 INFO - PROCESS | 16023 | __start_cc_report 07:53:34 INFO - PROCESS | 16023 | _x_x_mozilla_cycle_collect,1070 07:53:34 INFO - PROCESS | 16023 | __end_cc_report 07:53:34 INFO - PROCESS | 16023 | __startTimestamp1468335214536__endTimestamp 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | ------- Summary: start ------- 07:53:34 INFO - PROCESS | 16023 | Number of tests: 6 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#0] dojo.html Cycles:165 Average:4620.47 Median:4722.72 stddev:487.89 (10.3%) stddev-sans-first:462.42 07:53:34 INFO - PROCESS | 16023 | Values: 2581.2 2590.6 2620.4 2631.3 2633.4 4565.2 4611.1 4617.4 4633.9 4648.0 4656.6 4656.7 4689.2 4704.2 4707.6 4325.3 4326.0 4347.1 4357.7 4455.0 4317.4 4386.4 4396.4 4423.2 4429.3 4213.4 4324.2 4363.8 4385.4 4391.4 4208.5 4212.4 4247.1 4314.5 4317.3 4200.6 4256.0 4261.1 4266.4 4320.0 4578.7 4625.3 4647.9 4703.4 4716.0 4958.6 4980.1 4993.0 5065.5 5065.8 5047.5 5066.5 5083.3 5088.7 5116.7 4574.8 4691.2 4705.1 4712.9 4715.6 5147.7 5159.1 5235.1 5236.3 5251.0 4962.1 4972.8 4986.6 5026.7 5030.1 4863.2 4897.9 4936.6 5061.1 5107.3 4936.0 4946.2 4957.6 4961.1 5009.6 4925.2 4930.9 4931.5 4955.3 4985.9 4094.4 4115.4 4124.4 4193.3 4242.4 3634.1 3638.0 3683.0 3693.5 3720.4 4284.1 4291.9 4295.4 4297.1 4328.0 4875.4 4923.7 4966.9 4974.4 5009.9 4318.4 4322.0 4349.9 4356.1 4366.5 4504.2 4504.3 4504.8 4539.8 4566.0 4573.7 4639.6 4742.2 4745.1 4746.6 4921.4 4924.3 4959.9 4970.6 5023.6 4658.6 4668.1 4676.6 4680.0 4722.7 4814.0 4900.1 4915.0 4922.1 4967.0 4966.9 4990.6 4993.0 5007.2 5027.8 4860.3 4867.3 4869.8 4877.8 4900.7 4770.3 4860.6 4861.1 4912.9 4916.7 4782.3 4785.9 4812.1 4817.5 4877.5 4935.8 4937.6 4940.5 4941.2 4971.6 4697.1 4748.8 4790.4 4791.7 4834.4 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#1] ext.html Cycles:180 Average:47676.96 Median:37582.44 stddev:90360.02 (240.4%) stddev-sans-first:90544.26 07:53:34 INFO - PROCESS | 16023 | Values: 563.7 570.4 576.1 579.8 582.9 27005.7 39919.6 41027.6 41065.4 44267.3 41739.8 42374.4 42432.8 42456.4 42459.6 7859.3 7993.8 7993.8 7998.1 7999.8 7927.0 8002.6 8011.6 8025.5 8026.0 8037.5 8062.2 8081.1 8081.1 8084.0 8004.7 8027.0 8035.6 8039.6 8042.6 7885.3 7946.2 7950.2 7954.6 7958.6 39146.2 39454.0 39464.4 39531.8 39620.0 2399.4 2422.6 2435.0 2504.7 2633.6 29129.9 29685.7 29825.3 29993.5 31020.0 3500.0 3529.6 3568.1 3568.6 3598.7 190096.0 190608.0 190922.0 191100.0 191378.5 31790.5 53691.2 54031.0 54039.2 54346.5 32631.0 33749.8 33778.3 33786.7 33842.3 13023.6 13132.7 13132.7 13134.0 13141.9 11139.0 11208.7 11208.8 11218.8 11231.7 7919.2 7928.4 7949.3 7971.9 8015.0 3093.3 3103.8 3121.6 3129.1 3191.4 883.8 905.5 932.2 988.3 1004.7 26737.2 27579.6 27782.0 28603.9 28768.0 908.4 927.6 978.5 982.2 1015.9 14403.0 14950.0 15003.5 15240.1 15362.3 401844.0 403662.0 406508.0 406656.0 408490.0 50467.0 50928.2 51116.2 51208.0 51215.7 1017.0 1078.3 1175.9 1221.7 1224.8 27399.9 28570.9 28797.5 29098.9 29429.1 37027.6 46991.0 48126.0 48156.8 52804.0 380407.0 383973.0 385271.0 385481.0 385698.0 31431.8 37135.0 37799.4 38625.2 38713.6 41440.0 42642.6 42840.6 42909.4 43576.8 36685.4 36781.8 36831.6 37545.4 37619.4 36088.8 36095.5 36771.1 36844.0 37262.4 36144.0 36854.3 36902.6 37203.6 37272.8 31634.4 32678.7 32870.0 33385.5 33482.3 24917.6 25259.4 25269.7 25835.7 26034.0 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#2] jquery.html Cycles:180 Average:24761.18 Median:395949.50 stddev:65336.94 (16.5%) stddev-sans-first:65494.51 07:53:34 INFO - PROCESS | 16023 | Values: 346.1 361.5 366.8 375.3 377.4 13166.5 16491.3 17110.5 18426.2 18447.4 16905.9 17606.2 17657.4 17666.8 17696.6 4906.2 5138.3 5153.6 5154.4 5156.2 3668.9 5110.5 5881.8 6236.8 6246.8 6084.0 6178.9 6192.0 6196.5 6206.6 6001.5 6162.2 6171.5 6177.9 6183.5 3325.9 5033.5 5331.5 5409.8 5410.7 21358.3 21710.8 21967.6 21991.8 22044.1 1826.1 1841.4 2033.3 2063.0 2104.0 13330.3 13394.1 13576.7 13707.3 14051.4 1731.0 1813.3 1902.5 1904.6 1923.7 70116.6 70596.0 72733.3 73928.0 74723.0 9042.3 9380.0 10370.9 10420.2 10429.7 13748.5 14144.8 14322.9 14327.8 14345.3 7153.5 7206.9 7263.9 7266.1 7383.2 6885.3 6976.2 6984.7 7118.0 7119.7 4382.6 4430.6 4447.7 4452.4 4520.1 1763.2 1881.2 1887.6 1888.4 1902.5 783.8 837.4 881.8 888.4 894.0 17294.2 17441.4 17641.7 17850.6 18095.2 836.2 860.2 870.3 870.4 874.6 8123.5 9911.2 9925.3 9928.1 9963.8 389485.0 395384.0 396515.0 397574.0 399814.0 75574.0 78848.0 79349.6 79581.0 80108.0 840.8 861.3 863.0 867.6 870.5 15421.9 15623.2 15804.4 15959.0 16221.6 28131.9 34876.3 35338.6 38208.2 39311.0 48208.8 48716.5 48809.0 48916.0 49426.8 7172.3 7277.5 7303.0 7407.2 7528.4 10853.7 11268.8 11571.8 11822.0 11895.2 10007.2 10034.7 10337.3 10384.1 10728.6 10150.6 10451.9 10656.3 10739.2 11226.8 10726.9 10888.3 10894.3 11112.4 11183.0 6225.8 7820.4 7917.4 8035.4 8087.5 9898.0 10349.7 10351.3 10411.5 10472.2 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#3] mootools.html Cycles:180 Average:4931.59 Median:5400.13 stddev:2646.52 (49.0%) stddev-sans-first:2640.38 07:53:34 INFO - PROCESS | 16023 | Values: 1366.1 1407.9 1497.5 1687.3 1696.3 6961.2 7323.2 7400.4 7405.3 7410.6 6323.8 6519.4 7033.1 7242.0 7248.3 2208.4 2243.8 2245.8 2248.3 2249.9 1896.0 2199.4 2227.3 2229.5 2232.6 2116.5 2197.8 2198.0 2205.6 2206.4 2184.5 2196.8 2202.2 2206.3 2211.8 2176.9 2179.2 2179.5 2183.2 2185.6 7475.1 7521.1 7524.9 7533.9 7538.2 4239.9 4334.4 4350.8 4465.2 4532.2 2900.3 2996.0 3028.5 3035.7 3048.6 938.2 947.2 958.7 961.1 965.6 9833.3 9836.0 9867.6 9906.3 10000.1 4048.0 4077.4 4253.3 4259.0 4261.7 8374.5 8420.2 8438.0 8451.4 8470.7 4602.7 4610.8 4613.9 4619.9 4621.2 4139.9 4207.9 4223.4 4233.5 4238.3 3557.4 3564.9 3594.2 3667.7 3678.0 1037.1 1130.9 1142.7 1144.4 1186.7 804.9 814.7 839.3 857.6 857.9 5021.1 5110.8 5145.3 5211.2 5225.9 849.1 850.2 873.4 912.6 916.9 3473.4 3493.5 3531.6 3562.6 3567.1 8780.9 9052.4 9125.9 9149.3 9172.5 7918.4 8540.1 8893.8 8902.6 9074.8 6988.7 7063.5 7115.8 7123.5 7137.8 5226.5 5340.7 5353.9 5385.9 5414.4 8358.8 8545.9 8552.7 8699.3 8710.7 8578.5 8789.6 8796.3 8858.6 8859.5 6194.3 6277.8 6303.0 6336.0 6338.8 6710.2 6922.7 6959.8 7020.1 7067.5 4819.9 6463.0 6519.1 6561.4 6732.1 6329.1 6424.9 6457.2 6476.2 6533.8 6082.5 6093.5 6097.3 6116.6 6117.9 4391.9 4536.2 4547.7 4595.6 4698.0 4469.2 4483.8 4502.3 4552.3 4581.7 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#4] prototype.html Cycles:180 Average:4173.09 Median:4780.43 stddev:1207.14 (25.3%) stddev-sans-first:1174.83 07:53:34 INFO - PROCESS | 16023 | Values: 290.3 294.6 300.0 302.5 305.8 4780.3 4819.6 4838.3 4849.0 4872.8 4488.2 4636.3 4652.2 4664.0 4779.9 3614.1 3690.8 3705.1 3733.4 3752.0 3728.9 3752.7 3768.8 3770.2 3800.5 3615.3 3721.6 3730.9 3737.6 3747.3 3697.5 3708.8 3734.5 3737.0 3748.6 3271.6 3278.3 3278.9 3279.8 3285.7 4703.4 4704.6 4705.0 4707.9 4712.7 4159.5 4274.1 4304.3 4319.2 4347.5 4980.5 4991.0 5006.2 5015.2 5020.3 3622.1 3624.1 3625.2 3641.5 3657.4 4969.2 5275.8 5308.6 5324.9 5329.2 3647.6 3653.7 3660.7 3664.1 3673.1 3711.4 3713.7 3723.5 3727.6 3732.5 4279.7 4289.4 4290.4 4291.1 4293.2 4835.7 5007.5 5023.8 5048.8 5106.1 1277.6 1287.1 1300.8 1301.4 1304.7 834.6 867.9 890.4 899.0 901.9 4399.3 4401.4 4411.5 4416.3 4421.9 5082.6 5105.3 5109.3 5136.9 5149.6 4319.3 4361.6 4399.3 4411.9 4436.0 2686.4 2701.0 2701.9 2707.8 2709.6 4818.5 4827.7 4832.1 4836.8 4846.7 4969.3 5201.9 5203.8 5232.9 5240.2 4799.7 4805.6 4830.3 4839.8 4846.3 5072.3 5086.7 5088.5 5102.0 5106.9 4864.5 4960.8 5030.1 5119.9 5166.4 4873.6 4911.2 4915.5 4919.8 4935.9 3724.9 3725.6 3746.8 3747.7 3748.0 5138.4 5217.8 5235.2 5277.7 5282.0 5037.2 5053.5 5054.2 5066.7 5090.8 5009.4 5039.7 5044.6 5047.9 5076.0 4780.6 4861.8 5002.2 5005.7 5046.4 4982.6 5079.4 5096.5 5102.8 5117.5 4956.3 4994.5 5018.6 5029.1 5031.3 07:53:34 INFO - PROCESS | 16023 | 07:53:34 INFO - PROCESS | 16023 | [#5] yui.html Cycles:180 Average:15659.45 Median:478.39 stddev:21111.44 (4413.0%) stddev-sans-first:21140.52 07:53:34 INFO - PROCESS | 16023 | Values: 636.5 663.8 687.5 734.8 747.7 12181.5 13016.2 13021.6 13065.6 14898.2 14149.4 14223.9 14224.2 14238.6 14242.9 628.6 789.9 809.0 813.9 814.0 771.1 798.8 805.4 806.8 807.1 835.4 839.5 840.2 841.7 842.5 654.3 802.7 833.7 834.2 834.7 605.2 606.0 608.8 608.9 609.0 13003.9 13033.3 13058.7 13074.5 13105.4 11921.2 12347.9 12440.6 12534.2 12593.4 12072.8 12234.3 12298.6 12387.8 12675.5 4186.1 4254.6 4334.6 4417.8 4427.6 50516.2 50660.0 51160.7 68142.7 68169.3 9138.7 9324.3 9464.1 9536.2 9546.7 18260.0 18617.9 18648.5 18685.8 18692.7 6650.2 6726.5 6738.4 6755.1 7029.2 3677.6 3780.4 3780.9 3795.0 3845.2 2738.1 2819.2 2851.2 2853.2 2853.8 473.5 476.0 478.0 478.8 479.6 463.6 474.6 529.5 543.6 570.2 7543.2 7709.2 7749.4 7767.8 7896.0 486.9 503.7 547.8 604.7 649.4 4047.5 4074.8 4155.6 4213.7 4265.1 25750.9 25753.2 25784.6 25789.5 27527.7 82582.0 83500.1 84524.0 85292.1 85491.0 61792.1 69942.3 76364.6 77218.6 78045.0 8544.7 8822.0 8886.6 9044.9 9138.9 40037.0 41606.8 43534.4 46212.5 46484.8 57040.7 63426.4 63470.7 63651.0 65371.3 10523.9 10915.9 11020.6 11258.9 11267.8 12359.6 12468.9 13102.7 13611.7 14066.9 7467.0 11918.9 11953.6 12617.8 13213.7 12053.5 12127.4 12199.1 12529.6 12600.9 11508.7 11544.2 11619.8 11669.0 11836.8 9315.4 9464.7 9520.7 9755.6 9788.7 9757.9 9982.8 9989.7 10095.2 10125.6 07:53:34 INFO - PROCESS | 16023 | -------- Summary: end -------- 07:53:34 INFO - PROCESS | 16023 | 07:53:35 INFO - TEST-INFO | 16023: exit 0 07:53:35 INFO - TEST-OK | dromaeo_css | took 1119090ms 07:53:35 INFO - TEST-START | kraken 07:53:35 INFO - operating with platform_type : linux_ 07:53:35 INFO - Initialising browser for kraken test... 07:53:35 INFO - TEST-INFO | started process 16210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzbXIU/profile http://localhost:41961/getInfo.html) 07:53:39 INFO - PROCESS | 16210 | __metrics Screen width/height:1600/1200 07:53:39 INFO - PROCESS | 16210 | colorDepth:24 07:53:39 INFO - PROCESS | 16210 | Browser inner width/height: 1024/697 07:53:39 INFO - PROCESS | 16210 | __metrics 07:53:40 INFO - PROCESS | 16210 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:53:40 INFO - PROCESS | 16210 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:40 INFO - PROCESS | 16210 | console.error: PushService: 07:53:40 INFO - PROCESS | 16210 | stateChangeProcessEnqueue: Error transitioning state 07:53:40 INFO - PROCESS | 16210 | UnknownError 07:53:41 INFO - TEST-INFO | 16210: exit 0 07:53:41 INFO - Browser initialized. 07:53:41 INFO - Running cycle 1/1 for kraken test... 07:53:41 INFO - TEST-INFO | started process 16291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzbXIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:53 INFO - PROCESS | 16291 | RSS: Main: 159199232 07:53:53 INFO - PROCESS | 16291 | 07:53:55 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:56 INFO - PROCESS | 16291 | RSS: Main: 217473024 07:53:56 INFO - PROCESS | 16291 | 07:53:59 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-dft) 07:54:00 INFO - PROCESS | 16291 | RSS: Main: 204623872 07:54:00 INFO - PROCESS | 16291 | 07:54:03 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-fft) 07:54:03 INFO - PROCESS | 16291 | RSS: Main: 270848000 07:54:03 INFO - PROCESS | 16291 | 07:54:06 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-oscillator) 07:54:06 INFO - PROCESS | 16291 | RSS: Main: 181477376 07:54:06 INFO - PROCESS | 16291 | 07:54:08 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:09 INFO - PROCESS | 16291 | RSS: Main: 186400768 07:54:09 INFO - PROCESS | 16291 | 07:54:12 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:13 INFO - PROCESS | 16291 | RSS: Main: 221958144 07:54:13 INFO - PROCESS | 16291 | 07:54:16 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:17 INFO - PROCESS | 16291 | RSS: Main: 223756288 07:54:17 INFO - PROCESS | 16291 | 07:54:20 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41961/tests/kraken/driver.html?testName=json-parse-financial) 07:54:20 INFO - PROCESS | 16291 | RSS: Main: 222707712 07:54:20 INFO - PROCESS | 16291 | 07:54:22 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:23 INFO - PROCESS | 16291 | RSS: Main: 211546112 07:54:23 INFO - PROCESS | 16291 | 07:54:24 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:25 INFO - PROCESS | 16291 | RSS: Main: 213770240 07:54:25 INFO - PROCESS | 16291 | 07:54:27 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:28 INFO - PROCESS | 16291 | RSS: Main: 211173376 07:54:28 INFO - PROCESS | 16291 | 07:54:31 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:31 INFO - PROCESS | 16291 | RSS: Main: 225288192 07:54:31 INFO - PROCESS | 16291 | 07:54:34 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:35 INFO - PROCESS | 16291 | RSS: Main: 225705984 07:54:35 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41961/tests/kraken/driver.html?testName=ai-astar) 07:54:37 INFO - PROCESS | 16291 | RSS: Main: 267763712 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | __start_tp_report 07:54:37 INFO - PROCESS | 16291 | _x_x_mozilla_page_load 07:54:37 INFO - PROCESS | 16291 | _x_x_mozilla_page_load_details 07:54:37 INFO - PROCESS | 16291 | |i|pagename|runs| 07:54:37 INFO - PROCESS | 16291 | |0;ai-astar;104;115;115;116;114;114;114;115;114;114 07:54:37 INFO - PROCESS | 16291 | |1;audio-beat-detection;152;123;124;190;124;125;149;123;157;122 07:54:37 INFO - PROCESS | 16291 | |2;audio-dft;162;159;162;159;160;160;163;160;160;163 07:54:37 INFO - PROCESS | 16291 | |3;audio-fft;75;76;76;128;76;76;75;74;99;76 07:54:37 INFO - PROCESS | 16291 | |4;audio-oscillator;86;86;115;84;86;84;114;84;86;133 07:54:37 INFO - PROCESS | 16291 | |5;imaging-gaussian-blur;117;116;116;116;117;118;117;117;117;118 07:54:37 INFO - PROCESS | 16291 | |6;imaging-darkroom;146;147;146;147;146;146;147;147;146;146 07:54:37 INFO - PROCESS | 16291 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 07:54:37 INFO - PROCESS | 16291 | |8;json-parse-financial;64;69;64;64;64;64;64;65;65;63 07:54:37 INFO - PROCESS | 16291 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;66;66;65 07:54:37 INFO - PROCESS | 16291 | |10;stanford-crypto-aes;79;79;77;78;79;79;77;79;78;81 07:54:37 INFO - PROCESS | 16291 | |11;stanford-crypto-ccm;143;126;135;130;130;130;130;144;180;130 07:54:37 INFO - PROCESS | 16291 | |12;stanford-crypto-pbkdf2;166;168;168;163;165;166;164;165;165;165 07:54:37 INFO - PROCESS | 16291 | |13;stanford-crypto-sha256-iterative;69;67;71;68;66;65;65;65;66;66 07:54:37 INFO - PROCESS | 16291 | __end_tp_report 07:54:37 INFO - PROCESS | 16291 | __start_cc_report 07:54:37 INFO - PROCESS | 16291 | _x_x_mozilla_cycle_collect,1885 07:54:37 INFO - PROCESS | 16291 | __end_cc_report 07:54:37 INFO - PROCESS | 16291 | __startTimestamp1468335277277__endTimestamp 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | ------- Summary: start ------- 07:54:37 INFO - PROCESS | 16291 | Number of tests: 14 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.41 (3.0%) stddev-sans-first:0.73 07:54:37 INFO - PROCESS | 16291 | Values: 104.0 115.0 115.0 116.0 114.0 114.0 114.0 115.0 114.0 114.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:137.00 stddev:22.71 (16.6%) stddev-sans-first:23.59 07:54:37 INFO - PROCESS | 16291 | Values: 152.0 123.0 124.0 190.0 124.0 125.0 149.0 123.0 157.0 122.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 07:54:37 INFO - PROCESS | 16291 | Values: 162.0 159.0 162.0 159.0 160.0 160.0 163.0 160.0 160.0 163.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:17.43 (22.9%) stddev-sans-first:18.24 07:54:37 INFO - PROCESS | 16291 | Values: 75.0 76.0 76.0 128.0 76.0 76.0 75.0 74.0 99.0 76.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.91 (21.1%) stddev-sans-first:18.64 07:54:37 INFO - PROCESS | 16291 | Values: 86.0 86.0 115.0 84.0 86.0 84.0 114.0 84.0 86.0 133.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 07:54:37 INFO - PROCESS | 16291 | Values: 117.0 116.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 118.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:54:37 INFO - PROCESS | 16291 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:54:37 INFO - PROCESS | 16291 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:1.65 (2.6%) stddev-sans-first:1.73 07:54:37 INFO - PROCESS | 16291 | Values: 64.0 69.0 64.0 64.0 64.0 64.0 64.0 65.0 65.0 63.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:54:37 INFO - PROCESS | 16291 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:1.17 (1.5%) stddev-sans-first:1.24 07:54:37 INFO - PROCESS | 16291 | Values: 79.0 79.0 77.0 78.0 79.0 79.0 77.0 79.0 78.0 81.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:132.50 stddev:15.98 (12.1%) stddev-sans-first:16.84 07:54:37 INFO - PROCESS | 16291 | Values: 143.0 126.0 135.0 130.0 130.0 130.0 130.0 144.0 180.0 130.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 07:54:37 INFO - PROCESS | 16291 | Values: 166.0 168.0 168.0 163.0 165.0 166.0 164.0 165.0 165.0 165.0 07:54:37 INFO - PROCESS | 16291 | 07:54:37 INFO - PROCESS | 16291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.99 (3.0%) stddev-sans-first:1.94 07:54:37 INFO - PROCESS | 16291 | Values: 69.0 67.0 71.0 68.0 66.0 65.0 65.0 65.0 66.0 66.0 07:54:37 INFO - PROCESS | 16291 | -------- Summary: end -------- 07:54:37 INFO - PROCESS | 16291 | 07:54:38 INFO - TEST-INFO | 16291: exit 0 07:54:38 INFO - TEST-OK | kraken | took 63057ms 07:54:38 INFO - SUITE-END | took 1182s 07:54:38 INFO - Completed test suite (00:19:42) 07:54:38 INFO - javascript benchmark 07:54:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.186926118273, 2590.572555528338, 2620.384209710718, 2631.263246291037, 2633.4206474575585, 4565.223911934971, 4611.077784443112, 4617.445906491222, 4633.9073218535605, 4648.047150334181, 4656.557627025436, 4656.743879086657, 4689.179393606114, 4704.153252414564, 4707.552782485658, 4325.32957391604, 4325.978370108145, 4347.065380943112, 4357.738535687853, 4455.019895622958, 4317.417148684919, 4386.363977223301, 4396.406485124515, 4423.203823311803, 4429.269170586849, 4213.431186789775, 4324.17840610283, 4363.80362883671, 4385.407969924067, 4391.407160033386, 4208.494980602317, 4212.431321771553, 4247.108107297471, 4314.482262128565, 4317.287647538184, 4200.558941311179, 4255.97872010638, 4261.126469073833, 4266.424032755569, 4320.027993701424, 4578.656600754956, 4625.306204069383, 4647.930281045787, 4703.388559487279, 4716.033213191287, 4958.628102892261, 4980.078685443204, 4992.975035124838, 5065.493450654942, 5065.772040258197, 5047.49525047496, 5066.544011038987, 5083.262926875583, 5088.6692364996525, 5116.6674166179455, 4574.794134263966, 4691.179043667345, 4705.082508910764, 4712.882177945578, 4715.575598196178, 5147.6654017488745, 5159.1487404578575, 5235.110031294689, 5236.319278493771, 5250.973745131327, 4962.082014827269, 4972.7513624318635, 4986.551210391082, 5026.748662566857, 5030.119729047402, 4863.1732605457155, 4897.926531102036, 4936.580390666762, 5061.063703214917, 5107.310513080686, 4936.0, 4946.233333833262, 4957.578605818474, 4961.107000739829, 5009.599232061426, 4925.16272233714, 4930.8767280818265, 4931.506849315111, 4955.256711493233, 4985.925211121836, 4094.385842123705, 4115.42384066231, 4124.4019617155345, 4193.308104162779, 4242.406063151161, 3634.1459756957092, 3637.9818100909324, 3682.963170368316, 3693.4644476550748, 3720.404735242348, 4284.057507348379, 4291.935620965688, 4295.398644189816, 4297.119090586422, 4327.956720432819, 4875.366202393737, 4923.679960802537, 4966.875828104254, 4974.403071631355, 5009.89980200394, 4318.395424640553, 4321.984333681582, 4349.9130017399475, 4356.063446359048, 4366.476022877211, 4504.211762941472, 4504.34686970394, 4504.819807207675, 4539.818407263739, 4566.0411313623845, 4573.748443835488, 4639.582437580634, 4742.170120229015, 4745.050989802123, 4746.620270378361, 4921.384826896638, 4924.335214745964, 4959.925601116059, 4970.602351811919, 5023.648344615842, 4658.58072773452, 4668.137753204653, 4676.602488788491, 4680.0, 4722.716637001791, 4813.975930120327, 4900.14247506692, 4915.0, 4922.064807686528, 4967.031428871335, 4966.900661986812, 4990.575801056805, 4992.975035124801, 5007.173816320266, 5027.7737501813235, 4860.270959356125, 4867.29424233477, 4869.756512174448, 4877.756112194447, 4900.730459824744, 4770.308305295782, 4860.562549370574, 4861.149298872754, 4912.901741965212, 4916.729579873141, 4782.306565548046, 4785.904281914272, 4812.133815913169, 4817.494163112823, 4877.487863774252, 4935.802567897387, 4937.580305674058, 4940.456549779449, 4941.234108713155, 4971.627127965345, 4697.060587882369, 4748.786304616369, 4790.377250957354, 4791.688540244873, 4834.395700537433], "value": 4589.1069578806055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7237753500785, 570.4039278953493, 576.0926540698401, 579.7709904587688, 582.9387914269001, 27005.729942700567, 39919.60080399199, 41027.589724102785, 41065.38401923966, 44267.33598996018, 41739.79130104345, 42374.36438453426, 42432.78783606085, 42456.36315455263, 42459.575404245945, 7859.292663660255, 7993.800154996143, 7993.840123197532, 7998.080220774598, 7999.760007199793, 7926.960365198195, 8002.63988120533, 8011.599420029004, 8025.478343907656, 8025.959870200641, 8037.477563958353, 8062.19378062192, 8081.111077781439, 8081.111077781439, 8083.95958020209, 8004.679812807481, 8027.036755589366, 8035.633942229835, 8039.598020099001, 8042.638081286298, 7885.290323870821, 7946.245106714853, 7950.24472675095, 7954.602269886483, 7958.6418611162635, 39146.21707565861, 39454.0, 39464.40803387952, 39531.8023409884, 39620.0, 2399.3761621978238, 2422.5760491913843, 2434.9773095300015, 2504.724480307165, 2633.644457998165, 29129.85435072811, 29685.703142968727, 29825.25436864074, 29993.46353444516, 31020.0, 3499.9650003500146, 3529.6293889141784, 3568.107973006748, 3568.6431356864364, 3598.6941110005682, 190096.0, 190608.0, 190922.0, 191100.0, 191378.5172889631, 31790.523142152888, 53691.19463208055, 54031.0, 54039.18941215885, 54346.45653543414, 32631.0, 33749.83125084359, 33778.32443351168, 33786.662133378355, 33842.32315353679, 13023.609291721263, 13132.671683207996, 13132.737345253232, 13134.0, 13141.868581314257, 11139.0, 11208.66374008781, 11208.831867521994, 11218.831717524243, 11231.71920701989, 7919.247671471201, 7928.4450088494405, 7949.284564389232, 7971.920280797234, 8015.0, 3093.3040065985424, 3103.7672174586996, 3121.562981182636, 3129.0925631567047, 3191.3776813521604, 883.8099808541194, 905.515549181185, 932.2495391210141, 988.313122379939, 1004.7488127968008, 26737.19788406351, 27579.586306205423, 27782.0, 28603.85698071496, 28768.0, 908.3596064774318, 927.5872236854535, 978.4911845840123, 982.1602529837029, 1015.8933312002133, 14403.0, 14950.0, 15003.549893503212, 15240.085594864344, 15362.308696108701, 401844.0, 403662.0, 406508.0, 406656.0, 408490.0, 50467.0, 50928.23607645888, 51116.23325650118, 51208.0, 51215.743921280155, 1016.9745756356002, 1078.309881675728, 1175.9176857620055, 1221.73732647483, 1224.8407706998212, 27399.86300068487, 28570.857145714137, 28797.512646711588, 29098.854505727337, 29429.11712648624, 37027.629723703496, 46991.0, 48126.0, 48156.759216203696, 52804.0, 380407.0, 383973.0, 385271.0, 385481.0, 385698.0, 31431.842840785648, 37135.0, 37799.43300850435, 38625.2274954505, 38713.612863871, 41440.0, 42642.5735742651, 42840.57159428366, 42909.356359654004, 43576.78211608922, 36685.449718253716, 36781.816090919376, 36831.63168368282, 37545.4368184472, 37619.43570846385, 36088.81955590205, 36095.45856812097, 36771.08072298107, 36844.0, 37262.44106338353, 36144.0, 36854.26291474209, 36902.630973691, 37203.6279637211, 37272.81363593273, 31634.367312654078, 32678.673213267564, 32870.0, 33385.499217512246, 33482.33035339231, 24917.626235606844, 25259.368515787253, 25269.74730252674, 25835.741642584086, 26034.0], "value": 16737.23940454947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.14674826552545, 361.50654356802954, 366.76160495677806, 375.34689640026346, 377.38863041872156, 13166.473341066347, 16491.340346386147, 17110.486685399428, 18426.170822312994, 18447.44657660269, 16905.91547042266, 17606.20772065257, 17657.381991630296, 17666.82333176671, 17696.557586060357, 4906.190478571031, 5138.280640710285, 5153.613478989072, 5154.355705536808, 5156.200788877712, 3668.8715894943684, 5110.463401342861, 5881.823545293648, 6236.781712640059, 6246.843828904268, 6084.026555751081, 6178.876422471548, 6191.969040154793, 6196.473299769525, 6206.596571222856, 6001.519878409738, 6162.1681073055015, 6171.475424588915, 6177.876442471171, 6183.536234782387, 3325.8503367348526, 5033.521815427529, 5331.5201631853315, 5409.783608655649, 5410.729463526847, 21358.252461163785, 21710.78289217119, 21967.560648786934, 21991.780082199133, 22044.11823527057, 1826.0778306954903, 1841.3555255660547, 2033.3391647714552, 2063.0133310808496, 2103.95792084159, 13330.333483325892, 13394.129381590166, 13576.728465430735, 13707.314634268347, 14051.367688454044, 1731.047923641992, 1813.2928158018383, 1902.5053486093577, 1904.5905130396893, 1923.692209246528, 70116.6494167531, 70596.0, 72733.27266727318, 73927.99999999946, 74723.0, 9042.321825862955, 9379.98330358976, 10370.896291036994, 10420.166386689047, 10429.739256518647, 13748.518801841887, 14144.787828182585, 14322.928385358007, 14327.78508322376, 14345.282735863373, 7153.4992550520965, 7206.891896621555, 7263.92491535158, 7266.055412796409, 7383.2247614000835, 6885.311468853075, 6976.162860456778, 6984.720611175598, 7118.003479512872, 7119.71521139159, 4382.649388048949, 4430.645548356124, 4447.710898791633, 4452.4211852458975, 4520.118576877478, 1763.206557049333, 1881.1910878322453, 1887.5564242403025, 1888.3957133717354, 1902.4958386027713, 783.764870538836, 837.3970741066422, 881.8412685716504, 888.4225253585092, 893.9808618175285, 17294.221760020577, 17441.389551365894, 17641.7353739694, 17850.5537361567, 18095.185716642784, 836.188896770132, 860.1871231686122, 870.2776695342977, 870.4037734152126, 874.580201503282, 8123.530053885718, 9911.15755160805, 9925.305228633926, 9928.106470417697, 9963.800723985625, 389485.0, 395384.0, 396515.0, 397574.0, 399814.0, 75574.0, 78848.0, 79349.60325198337, 79581.0, 80108.0, 840.8318336332758, 861.3410740783306, 862.9741107766652, 867.5748883047388, 870.5342641686793, 15421.922890385926, 15623.218839058229, 15804.36782528686, 15959.0, 16221.59446013859, 28131.859340703166, 34876.30247394987, 35338.646613533536, 38208.23583528258, 39311.0, 48208.758956205, 48716.512834871195, 48809.0, 48916.0, 49426.75286623544, 7172.282771722995, 7277.490575659653, 7302.963485182752, 7407.1852096268285, 7528.360089392463, 10853.728656783644, 11268.830967535658, 11571.826422603499, 11821.986077681126, 11895.226810257305, 10007.249456290952, 10034.749131271778, 10337.328073675188, 10384.065434110966, 10728.570857165625, 10150.644727434505, 10451.895481045092, 10656.254062215881, 10739.194560407845, 11226.831597526207, 10726.892731072589, 10888.292261003326, 10894.291871028357, 11112.444377781241, 11183.0, 6225.750969961332, 7820.413468989735, 7917.406194535548, 8035.397345199017, 8087.47431416956, 9897.950510247403, 10349.689509314732, 10351.275410721177, 10411.531481083219, 10472.214583906085], "value": 8398.85089927429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.0847232354317, 1407.8803301719354, 1497.4534294982327, 1687.3419366447088, 1696.3384280130742, 6961.199462061864, 7323.157836848764, 7400.407967362611, 7405.333519983201, 7410.555366678003, 6323.77866774663, 6519.445847103002, 7033.085698859154, 7242.022326985855, 7248.311410416015, 2208.3595757230382, 2243.7644047375034, 2245.764194759543, 2248.2917880867476, 2249.898754556049, 1895.9526011849746, 2199.3511913985412, 2227.2984010036785, 2229.487217939875, 2232.6427771556555, 2116.5449428372895, 2197.8241740660787, 2198.043850924853, 2205.647096464566, 2206.3932418584936, 2184.4866456382897, 2196.769339219375, 2202.1631779923605, 2206.2609025976317, 2211.7677643847323, 2176.869387836735, 2179.2372669565684, 2179.498715295475, 2183.2140429445385, 2185.5628874225217, 7475.140358858746, 7521.097468303784, 7524.887126693104, 7533.886991695129, 7538.246175382473, 4239.915201695949, 4334.393184954109, 4350.782460876975, 4465.218586747339, 4532.184206842767, 2900.2894290898653, 2996.0, 3028.530577760451, 3035.696430356969, 3048.557959095941, 938.2072149034055, 947.1806887042727, 958.6788425877339, 961.1445813226235, 965.5896244096231, 9833.31166818323, 9835.96722344158, 9867.555959981819, 9906.257030722652, 10000.149987251092, 4047.9797601012397, 4077.4495443115393, 4253.298205796071, 4258.978705106455, 4261.680373971964, 8374.53940033304, 8420.242178203991, 8437.957810211032, 8451.36614753896, 8470.745877623682, 4602.700824446467, 4610.815567377267, 4613.861584152481, 4619.86140415788, 4621.237495813153, 4139.8965025874595, 4207.894802629898, 4223.366495025709, 4233.470816147981, 4238.300680387763, 3557.4130268505924, 3564.8574057037426, 3594.2092739597247, 3667.651573100551, 3677.9816100919325, 1037.1339931157568, 1130.949107290174, 1142.651491295163, 1144.3534403062242, 1186.7033241689578, 804.9315808156255, 814.6578437056451, 839.2711015308362, 857.6269322844582, 857.8756080368437, 5021.121303771825, 5110.7955681773055, 5145.279660847485, 5211.166213405837, 5225.947740522623, 849.1169184048644, 850.2093053460218, 873.4148120759106, 912.6395073945754, 916.9213670464007, 3473.4442489201606, 3493.528373669573, 3531.5938667053106, 3562.59030211529, 3567.090391950036, 8780.912190878009, 9052.411593246417, 9125.863112053325, 9149.313801464918, 9172.495512746864, 7918.366530677532, 8540.14598540141, 8893.777655558662, 8902.554872256362, 9074.818503629891, 6988.720451181997, 7063.505554611231, 7115.75094871677, 7123.465740069516, 7137.785866424016, 5226.451222621722, 5340.652857564246, 5353.919691204557, 5385.919211211756, 5414.35027796667, 8358.791030224293, 8545.871811922701, 8552.743417697478, 8699.260562852229, 8710.69512567057, 8578.485290882567, 8789.648414063366, 8796.340274479568, 8858.601362938554, 8859.512726800089, 6194.349593292639, 6277.811665650038, 6302.968485157545, 6335.954567496311, 6338.809835704937, 6710.194776626836, 6922.653867306513, 6959.756408525677, 7020.0522929405915, 7067.5052746307265, 4819.855404337875, 6463.0, 6519.08732777402, 6561.40947314744, 6732.124823772878, 6329.113924050729, 6424.9036264455135, 6457.225132983884, 6476.190476190476, 6533.771318003847, 6082.513398928164, 6093.451589356979, 6097.2683278006925, 6116.633002019893, 6117.938820611737, 4391.890202744957, 4536.183486972244, 4547.704399214041, 4595.563421474954, 4697.976510117427, 4469.190127669734, 4483.843065492692, 4502.302143167814, 4552.271636538138, 4581.74800385982], "value": 4038.161297567576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.29458416048993, 294.6096422240531, 299.9640043194816, 302.51748461204386, 305.7798385162682, 4780.2590598457255, 4819.5662390384905, 4838.298446725223, 4848.951510484899, 4872.805087796484, 4488.1696886076015, 4636.2581986882105, 4652.185867473196, 4663.953360466395, 4779.856604301876, 3614.114541937216, 3690.7970061646597, 3705.12929461577, 3733.4213196954515, 3751.962480375202, 3728.8694895678655, 3752.6810221131236, 3768.8492460301554, 3770.189409277005, 3800.5059342285463, 3615.313090512794, 3721.62783721627, 3730.850765969358, 3737.5514938207452, 3747.3067482515685, 3697.4638677391895, 3708.8145592720525, 3734.477173195755, 3736.9626303737023, 3748.6063963283736, 3271.607407111138, 3278.2623909620384, 3278.9016329510155, 3279.8360081995806, 3285.6878596533293, 4703.412073490814, 4704.623630109583, 4704.95295047052, 4707.917179048838, 4712.670113092085, 4159.459270294872, 4274.123804620045, 4304.332828411601, 4319.157764235975, 4347.456567929009, 4980.452150263468, 4990.975045124787, 5006.173981293082, 5015.1975683890405, 5020.272060551236, 3622.1487950331652, 3624.0939765058733, 3625.23869987303, 3641.4901913732097, 3657.3965295726175, 4969.235921247977, 5275.762590683428, 5308.601854860863, 5324.896665817019, 5329.2006199070065, 3647.6170002149925, 3653.6981701527866, 3660.6888414484533, 3664.102294937704, 3673.145061743802, 3711.406175011985, 3713.7400381973002, 3723.515942927402, 3727.552693676722, 3732.458793474931, 4279.667581168271, 4289.399484072233, 4290.399344091829, 4291.098869237433, 4293.248681480791, 4835.685680430761, 5007.474215207423, 5023.773930173151, 5048.7728052237735, 5106.131957567222, 1277.5975567696146, 1287.1183239480986, 1300.7528569571941, 1301.3883474766844, 1304.6803533134253, 834.6145398638231, 867.9435836670597, 890.4479222881855, 898.9775255618531, 901.9278457723366, 4399.274119770202, 4401.449818772653, 4411.4926783420315, 4416.31547110192, 4421.9336709949375, 5082.593392528663, 5105.26868125551, 5109.3139264042775, 5136.897262054738, 5149.588032957355, 4319.287317592625, 4361.629261512743, 4399.274119770266, 4411.9043454358925, 4435.955640443619, 2686.449277898026, 2700.9729902701115, 2701.91894243173, 2707.837529748221, 2709.5749304372475, 4818.494058123846, 4827.710337379768, 4832.081904438145, 4836.782344794493, 4846.733429661403, 4969.254611808257, 5201.867234433864, 5203.791848326025, 5232.927249913759, 5240.187770895517, 4799.66402351839, 4805.639577031737, 4830.3237546743485, 4839.782209800567, 4846.273059041031, 5072.28987941681, 5086.669366491166, 5088.48120180513, 5102.0, 5106.948930510796, 4864.513548645107, 4960.7767650456535, 5030.144875371123, 5119.92320115206, 5166.4316925137455, 4873.561379475864, 4911.189653707098, 4915.459299476983, 4919.770057485629, 4935.901281974268, 3724.888253352404, 3725.590185079693, 3746.8313925873945, 3747.7376583638884, 3747.981260093682, 5138.409082955508, 5217.843464696065, 5235.214717792362, 5277.683338999673, 5281.973590132025, 5037.244413338029, 5053.519915608012, 5054.19132938728, 5066.746662666926, 5090.796368145381, 5009.4489606144025, 5039.748012599429, 5044.596432285335, 5047.949520504748, 5076.0, 4780.593649539828, 4861.829835955725, 5002.2496625506465, 5005.749712514433, 5046.419661738947, 4982.6297768114055, 5079.415867175322, 5096.51583099605, 5102.821401250939, 5117.462666420121, 4956.306117143675, 4994.500549944976, 5018.623603229699, 5029.06962211992, 5031.270465782368], "value": 3791.4928693228208, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.4780879678664, 663.7544108679789, 687.4809518813295, 734.7795661301611, 747.7009196321472, 12181.45183466744, 13016.219026858384, 13021.60935171944, 13065.608031759039, 14898.180600066991, 14149.36327865246, 14223.857761422383, 14224.217668028281, 14238.644033899158, 14242.928785356085, 628.6196850905205, 789.8538770327493, 808.9919100808976, 813.8738495533172, 814.0028465130227, 771.090113665874, 798.7763426240633, 805.3677862877643, 806.8426656801926, 807.0638059850575, 835.4360806455649, 839.4837175137277, 840.2185967050641, 841.7264389073545, 842.4860834890711, 654.3489228217906, 802.6869520886859, 833.7040350675513, 834.1825011488775, 834.6869923778584, 605.2162449627699, 605.9818205453844, 608.7747533412621, 608.9238845144357, 608.984775380619, 13003.869961300361, 13033.283169425678, 13058.738825223538, 13074.542391016268, 13105.410256538478, 11921.225120367235, 12347.938260308641, 12440.564580239648, 12534.24794512323, 12593.433295501725, 12072.758544829054, 12234.327112008836, 12298.631041068782, 12387.75224495505, 12675.492980280778, 4186.1418409226035, 4254.595813397722, 4334.631556317717, 4417.845375411877, 4427.579379958899, 50516.24225636618, 50660.0, 51160.74419627878, 68142.65928670374, 68169.3183068173, 9138.680146194984, 9324.25405967521, 9464.148226659496, 9536.2371010319, 9546.665866694633, 18260.0, 18617.90691046536, 18648.533786655444, 18685.81314186868, 18692.719609205873, 6650.235222949326, 6726.529142960044, 6738.393544581011, 6755.121834161528, 7029.191642961023, 3677.595464498903, 3780.4140358244517, 3780.8676696316047, 3795.0, 3845.2309538092495, 2738.137486691686, 2819.196528989269, 2851.21591562322, 2853.215365774429, 2853.814502057401, 473.54066555441165, 476.014649675176, 477.95459431353964, 478.82448588714624, 479.63547703745405, 463.60130287952336, 474.5728844040322, 529.4625954656027, 543.5868739757813, 570.1732487892573, 7543.207963163899, 7709.190534993857, 7749.418793590503, 7767.805804854811, 7896.0, 486.85881094482914, 503.65247978894445, 547.8274343581759, 604.6734763227807, 649.3960616626582, 4047.4738284022887, 4074.7758873262255, 4155.625993660585, 4213.747175169499, 4265.0830071534765, 25750.871245644026, 25753.227403177934, 25784.61323080155, 25789.484210316063, 27527.724722752915, 82582.0, 83500.0774972873, 84524.0, 85292.14707852842, 85491.0, 61792.073118904154, 69942.30057699358, 76364.61817690876, 77218.6139069301, 78045.0, 8544.74365769028, 8822.0, 8886.60010299551, 9044.864327034968, 9138.862917056116, 40037.0, 41606.79196603998, 43534.3879367239, 46212.53787462082, 46484.7675761619, 57040.71479642575, 63426.36573634389, 63470.68264658647, 63651.0, 65371.34628653653, 10523.94738026305, 10915.945420272848, 11020.614278500214, 11258.887411126112, 11267.830982535104, 12359.567415140427, 12468.875311247135, 13102.672433189247, 13611.659708507366, 14066.859331406964, 7466.962665186639, 11918.940405297919, 11953.581624643095, 12617.810732839198, 13213.735725285633, 12053.51785928553, 12127.393630318273, 12199.146059776085, 12529.624111276677, 12600.873991260336, 11508.712282193012, 11544.19190656646, 11619.76760464769, 11669.0, 11836.822447663464, 9315.441073535609, 9464.668736594185, 9520.714378568655, 9755.60977560918, 9788.657396991071, 9757.853632195665, 9982.750431238986, 9989.700308990741, 10095.242856785624, 10125.64560240388], "value": 6350.617998243017, "unit": "score"}], "name": "dromaeo_css", "value": 6303.501460246509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 124.0, 190.0, 124.0, 125.0, 149.0, 123.0, 157.0, 122.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 159.0, 160.0, 160.0, 163.0, 160.0, 160.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 128.0, 76.0, 76.0, 75.0, 74.0, 99.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 84.0, 86.0, 84.0, 114.0, 84.0, 86.0, 133.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "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": [64.0, 69.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 78.0, 79.0, 79.0, 77.0, 79.0, 78.0, 81.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 126.0, 135.0, 130.0, 130.0, 130.0, 130.0, 144.0, 180.0, 130.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 168.0, 163.0, 165.0, 166.0, 164.0, 165.0, 165.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 71.0, 68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1528.9999999999998, "alertThreshold": 2.0}]} 07:54:38 INFO - Return code: 0 07:54:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:54:38 INFO - # TBPL SUCCESS # 07:54:38 INFO - Running post-action listener: _resource_record_post_action 07:54:38 INFO - ##### 07:54:38 INFO - ##### Finished run-tests step (success) 07:54:38 INFO - ##### 07:54:38 INFO - Running post-run listener: _resource_record_post_run 07:54:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545964032; Read time: 8; Write time: 401772 07:54:38 INFO - TinderboxPrint: CPU usage
13.0% 07:54:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:54:38 INFO - TinderboxPrint: I/O write bytes / time
545,964,032 / 401,772 07:54:38 INFO - TinderboxPrint: CPU idle
8,329.5 (87.0%) 07:54:38 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 07:54:38 INFO - TinderboxPrint: Swap in / out
0 / 0 07:54:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257683456; Read time: 0; Write time: 221704 07:54:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287997952; Read time: 8; Write time: 180044 07:54:39 INFO - Running post-run listener: _upload_blobber_files 07:54:39 INFO - Blob upload gear active. 07:54:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:54:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:54:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:54:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:40 INFO - (blobuploader) - INFO - Done attempting. 07:54:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:54:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:41 INFO - (blobuploader) - INFO - Done attempting. 07:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:45 INFO - (blobuploader) - INFO - Done attempting. 07:54:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:54:45 INFO - Return code: 0 07:54:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:54:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:54:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/364d3e74110ed2661e644d63cd020de5cd61d1fa58a5176eeb450beb6a8b03beb6e5f5bb734211ba695a711aa9d8ae7ba20e56a13c40ba1767ffdbfd1e727c9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3484fb5c3f95389b147ccd6edf49d1de9ef4274ed71680203b61bb271b85595050a7e664adfc8e9f2807858dcd266cdf02aa7bd6b7885fb1be3f234b1e600532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8438cf70b61b3feeff303f86319ebedae16e5a6ab83f55ad320ef5930ac8a9d4028e4da64a7f26439a0292c9905739964e6f70c27e8a1f4db30992859a405051"} 07:54:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:54:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:54:45 INFO - Contents: 07:54:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/364d3e74110ed2661e644d63cd020de5cd61d1fa58a5176eeb450beb6a8b03beb6e5f5bb734211ba695a711aa9d8ae7ba20e56a13c40ba1767ffdbfd1e727c9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3484fb5c3f95389b147ccd6edf49d1de9ef4274ed71680203b61bb271b85595050a7e664adfc8e9f2807858dcd266cdf02aa7bd6b7885fb1be3f234b1e600532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8438cf70b61b3feeff303f86319ebedae16e5a6ab83f55ad320ef5930ac8a9d4028e4da64a7f26439a0292c9905739964e6f70c27e8a1f4db30992859a405051"} 07:54:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:54:45 INFO - Copying logs to upload dir... 07:54:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:54:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.426555 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-12 07:54:44.982936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 07:54:44.987163) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/364d3e74110ed2661e644d63cd020de5cd61d1fa58a5176eeb450beb6a8b03beb6e5f5bb734211ba695a711aa9d8ae7ba20e56a13c40ba1767ffdbfd1e727c9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3484fb5c3f95389b147ccd6edf49d1de9ef4274ed71680203b61bb271b85595050a7e664adfc8e9f2807858dcd266cdf02aa7bd6b7885fb1be3f234b1e600532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8438cf70b61b3feeff303f86319ebedae16e5a6ab83f55ad320ef5930ac8a9d4028e4da64a7f26439a0292c9905739964e6f70c27e8a1f4db30992859a405051"} build_url:https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/BPZNGXy3Tlu91KI3Qur4Jg/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/Fx-Team-Non-PGO/sha512/364d3e74110ed2661e644d63cd020de5cd61d1fa58a5176eeb450beb6a8b03beb6e5f5bb734211ba695a711aa9d8ae7ba20e56a13c40ba1767ffdbfd1e727c9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3484fb5c3f95389b147ccd6edf49d1de9ef4274ed71680203b61bb271b85595050a7e664adfc8e9f2807858dcd266cdf02aa7bd6b7885fb1be3f234b1e600532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8438cf70b61b3feeff303f86319ebedae16e5a6ab83f55ad320ef5930ac8a9d4028e4da64a7f26439a0292c9905739964e6f70c27e8a1f4db30992859a405051"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 07:54:45.014728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:54:45.015266) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468333746.81446-1546355828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 07:54:45.099894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 07:54:45.100430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 07:54:45.100964) ========= ========= Total master_lag: 0.18 =========