builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1467981482.89 results: success (0) buildid: 20160708031827 builduid: fa833bd764404eef84f504d18f49689f revision: 00b612e67c091e3e5899fe5e8a60870ed1a910f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:02.895009) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:02.895682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:02.896124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:02.913618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:02.914171) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 05:38:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.7M=0s 2016-07-08 05:38:03 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.023119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.023454) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013711 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.073549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.073912) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00b612e67c091e3e5899fe5e8a60870ed1a910f2 --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 00b612e67c091e3e5899fe5e8a60870ed1a910f2 --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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 05:38:03,312 truncating revision to first 12 chars 2016-07-08 05:38:03,312 Setting DEBUG logging. 2016-07-08 05:38:03,312 attempt 1/10 2016-07-08 05:38:03,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00b612e67c09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 05:38:03,614 unpacking tar archive at: fx-team-00b612e67c09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.727572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.727980) ========= script_repo_revision: 00b612e67c091e3e5899fe5e8a60870ed1a910f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.728426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.728854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:38:03.740899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 05:38:03.741256) ========= /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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:38:04 INFO - MultiFileLogger online at 20160708 05:38:04 in /builds/slave/test 05:38:04 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 05:38:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:04 INFO - {'append_to_log': False, 05:38:04 INFO - 'base_work_dir': '/builds/slave/test', 05:38:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:38:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:04 INFO - 'branch': 'Fx-Team-Non-PGO', 05:38:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:04 INFO - 'config_files': ('talos/linux_config.py',), 05:38:04 INFO - 'default_actions': ('clobber', 05:38:04 INFO - 'read-buildbot-config', 05:38:04 INFO - 'download-and-extract', 05:38:04 INFO - 'populate-webroot', 05:38:04 INFO - 'create-virtualenv', 05:38:04 INFO - 'install', 05:38:04 INFO - 'run-tests'), 05:38:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:04 INFO - 'download_minidump_stackwalk': True, 05:38:04 INFO - 'download_symbols': 'ondemand', 05:38:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:04 INFO - 'installer_path': 'installer.exe', 05:38:04 INFO - 'log_level': 'info', 05:38:04 INFO - 'log_name': 'talos', 05:38:04 INFO - 'log_to_console': True, 05:38:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:38:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:38:04 INFO - 'opt_config_files': (), 05:38:04 INFO - 'pip_index': False, 05:38:04 INFO - 'sps_profile': False, 05:38:04 INFO - 'sps_profile_interval': 0, 05:38:04 INFO - 'suite': 'dromaeojs', 05:38:04 INFO - 'system_bits': '32', 05:38:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:04 INFO - 'title': 'talos-linux64-ix-036', 05:38:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:04 INFO - 'use_talos_json': True, 05:38:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:04 INFO - 'work_dir': 'build'} 05:38:04 INFO - ##### 05:38:04 INFO - ##### Running clobber step. 05:38:04 INFO - ##### 05:38:04 INFO - Running pre-action listener: _resource_record_pre_action 05:38:04 INFO - Running main action method: clobber 05:38:04 INFO - rmtree: /builds/slave/test/build 05:38:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:05 INFO - Running post-action listener: _resource_record_post_action 05:38:05 INFO - ##### 05:38:05 INFO - ##### Finished clobber step (success) 05:38:05 INFO - ##### 05:38:05 INFO - ##### 05:38:05 INFO - ##### Running read-buildbot-config step. 05:38:05 INFO - ##### 05:38:05 INFO - Running pre-action listener: _resource_record_pre_action 05:38:05 INFO - Running main action method: read_buildbot_config 05:38:05 INFO - Using buildbot properties: 05:38:05 INFO - { 05:38:05 INFO - "project": "", 05:38:05 INFO - "product": "firefox", 05:38:05 INFO - "script_repo_revision": "production", 05:38:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:38:05 INFO - "repository": "", 05:38:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:38:05 INFO - "buildid": "20160708031827", 05:38:05 INFO - "pgo_build": "False", 05:38:05 INFO - "basedir": "/builds/slave/test", 05:38:05 INFO - "buildnumber": 1952, 05:38:05 INFO - "slavename": "talos-linux64-ix-036", 05:38:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:38:05 INFO - "platform": "ubuntu64_hw", 05:38:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:38:05 INFO - "branch": "fx-team", 05:38:05 INFO - "repo_path": "integration/fx-team", 05:38:05 INFO - "revision": "00b612e67c091e3e5899fe5e8a60870ed1a910f2", 05:38:05 INFO - "stage_platform": "linux64", 05:38:05 INFO - "builduid": "fa833bd764404eef84f504d18f49689f", 05:38:05 INFO - "slavebuilddir": "test" 05:38:05 INFO - } 05:38:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:38:05 INFO - Running post-action listener: _resource_record_post_action 05:38:05 INFO - ##### 05:38:05 INFO - ##### Finished read-buildbot-config step (success) 05:38:05 INFO - ##### 05:38:05 INFO - ##### 05:38:05 INFO - ##### Running download-and-extract step. 05:38:05 INFO - ##### 05:38:05 INFO - Running pre-action listener: _resource_record_pre_action 05:38:05 INFO - Running main action method: download_and_extract 05:38:05 INFO - mkdir: /builds/slave/test/build/tests 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:05 INFO - https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:38:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:38:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:38:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:05 INFO - Downloaded 1361 bytes. 05:38:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:38:05 INFO - Using the following test package requirements: 05:38:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:38:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:38:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:38:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'jsshell-linux-x86_64.zip'], 05:38:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:38:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:38:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:38:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:38:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:38:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:38:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:05 INFO - https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:38:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:38:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:06 INFO - Downloaded 22734685 bytes. 05:38:06 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'] 05:38:06 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 05:38:08 INFO - Return code: 0 05:38:08 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 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:09 INFO - Downloaded 22734685 bytes. 05:38:09 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'] 05:38:09 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 05:38:10 INFO - Return code: 0 05:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:38:10 INFO - https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:12 INFO - Downloaded 14403333 bytes. 05:38:12 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'] 05:38:12 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 05:38:12 INFO - Return code: 0 05:38:12 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')]} 05:38:12 INFO - https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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 05:38:14 INFO - Downloaded 56652139 bytes. 05:38:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:38:14 INFO - mkdir: /builds/slave/test/properties 05:38:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:38:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:38:14 INFO - Contents: 05:38:14 INFO - build_url:https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:38:15 INFO - Running post-action listener: _resource_record_post_action 05:38:15 INFO - Running post-action listener: set_extra_try_arguments 05:38:15 INFO - ##### 05:38:15 INFO - ##### Finished download-and-extract step (success) 05:38:15 INFO - ##### 05:38:15 INFO - ##### 05:38:15 INFO - ##### Running populate-webroot step. 05:38:15 INFO - ##### 05:38:15 INFO - Running pre-action listener: _resource_record_pre_action 05:38:15 INFO - Running main action method: populate_webroot 05:38:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:38:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:38:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:38:15 INFO - '--tppagecycles', 05:38:15 INFO - '7'], 05:38:15 INFO - 'tests': ['tsvgm']}}, 05:38:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:38:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:38:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:38:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:38:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['damp', 'tps']}, 05:38:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'tests': ['damp', 'tps']}, 05:38:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['dromaeo_dom']}, 05:38:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:38:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['basic_compositor_video']}, 05:38:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:38:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['a11yr', 05:38:15 INFO - 'ts_paint', 05:38:15 INFO - 'tpaint', 05:38:15 INFO - 'sessionrestore', 05:38:15 INFO - 'sessionrestore_no_auto_restore', 05:38:15 INFO - 'tabpaint']}, 05:38:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['tsvgx', 05:38:15 INFO - 'tsvgr_opacity', 05:38:15 INFO - 'tart', 05:38:15 INFO - 'tscrollx', 05:38:15 INFO - 'cart']}, 05:38:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:38:15 INFO - 'tsvgr_opacity', 05:38:15 INFO - 'tart', 05:38:15 INFO - 'tscrollx', 05:38:15 INFO - 'cart']}, 05:38:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'talos_options': ['--disable-e10s'], 05:38:15 INFO - 'tests': ['tp5o']}, 05:38:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'tests': ['tp5o']}, 05:38:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'talos_options': ['--disable-e10s', 05:38:15 INFO - '--xperf_path', 05:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:15 INFO - 'tests': ['tp5n']}, 05:38:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:15 INFO - 'talos_options': ['--xperf_path', 05:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:15 INFO - 'tests': ['tp5n']}}, 05:38:15 INFO - 'talos.zip': {'path': '', 05:38:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:38:15 INFO - Running post-action listener: _resource_record_post_action 05:38:15 INFO - ##### 05:38:15 INFO - ##### Finished populate-webroot step (success) 05:38:15 INFO - ##### 05:38:15 INFO - ##### 05:38:15 INFO - ##### Running create-virtualenv step. 05:38:15 INFO - ##### 05:38:15 INFO - Running pre-action listener: _resource_record_pre_action 05:38:15 INFO - Running main action method: create_virtualenv 05:38:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:38:15 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 05:38:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:38:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:38:15 INFO - Using real prefix '/usr' 05:38:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:38:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:38:17 INFO - Installing pip.................done. 05:38:17 INFO - Return code: 0 05:38:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:17 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 05:38:17 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 05:38:17 INFO - Using env: {'DISPLAY': ':0', 05:38:17 INFO - 'HOME': '/home/cltbld', 05:38:17 INFO - 'LANG': 'en_US.UTF-8', 05:38:17 INFO - 'LANGUAGE': 'en_US:en', 05:38:17 INFO - 'LOGNAME': 'cltbld', 05:38:17 INFO - 'MAIL': '/var/mail/cltbld', 05:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:17 INFO - 'MOZ_NO_REMOTE': '1', 05:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:17 INFO - 'NO_EM_RESTART': '1', 05:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:17 INFO - 'PWD': '/builds/slave/test', 05:38:17 INFO - 'SHELL': '/bin/bash', 05:38:17 INFO - 'SHLVL': '1', 05:38:17 INFO - 'TERM': 'linux', 05:38:17 INFO - 'TMOUT': '86400', 05:38:17 INFO - 'USER': 'cltbld', 05:38:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:17 INFO - '_': '/tools/buildbot/bin/python'} 05:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:17 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 05:38:17 INFO - Cleaning up... 05:38:17 INFO - Return code: 0 05:38:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:17 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 05:38:17 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 05:38:17 INFO - Using env: {'DISPLAY': ':0', 05:38:17 INFO - 'HOME': '/home/cltbld', 05:38:17 INFO - 'LANG': 'en_US.UTF-8', 05:38:17 INFO - 'LANGUAGE': 'en_US:en', 05:38:17 INFO - 'LOGNAME': 'cltbld', 05:38:17 INFO - 'MAIL': '/var/mail/cltbld', 05:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:17 INFO - 'MOZ_NO_REMOTE': '1', 05:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:17 INFO - 'NO_EM_RESTART': '1', 05:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:17 INFO - 'PWD': '/builds/slave/test', 05:38:17 INFO - 'SHELL': '/bin/bash', 05:38:17 INFO - 'SHLVL': '1', 05:38:17 INFO - 'TERM': 'linux', 05:38:17 INFO - 'TMOUT': '86400', 05:38:17 INFO - 'USER': 'cltbld', 05:38:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:17 INFO - '_': '/tools/buildbot/bin/python'} 05:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:18 INFO - Downloading/unpacking psutil>=3.1.1 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:20 INFO - Installing collected packages: psutil 05:38:20 INFO - Running setup.py install for psutil 05:38:20 INFO - building 'psutil._psutil_linux' extension 05:38:20 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 05:38:20 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 05:38:20 INFO - building 'psutil._psutil_posix' extension 05:38:20 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 05:38:20 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 05:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:20 INFO - Successfully installed psutil 05:38:20 INFO - Cleaning up... 05:38:20 INFO - Return code: 0 05:38:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:38: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 mozsystemmonitor==0.3 05:38:20 INFO - Using env: {'DISPLAY': ':0', 05:38:20 INFO - 'HOME': '/home/cltbld', 05:38:20 INFO - 'LANG': 'en_US.UTF-8', 05:38:20 INFO - 'LANGUAGE': 'en_US:en', 05:38:20 INFO - 'LOGNAME': 'cltbld', 05:38:20 INFO - 'MAIL': '/var/mail/cltbld', 05:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:20 INFO - 'MOZ_NO_REMOTE': '1', 05:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:20 INFO - 'NO_EM_RESTART': '1', 05:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:20 INFO - 'PWD': '/builds/slave/test', 05:38:20 INFO - 'SHELL': '/bin/bash', 05:38:20 INFO - 'SHLVL': '1', 05:38:20 INFO - 'TERM': 'linux', 05:38:20 INFO - 'TMOUT': '86400', 05:38:20 INFO - 'USER': 'cltbld', 05:38:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:20 INFO - '_': '/tools/buildbot/bin/python'} 05:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:38:22 INFO - Installing collected packages: mozsystemmonitor 05:38:22 INFO - Running setup.py install for mozsystemmonitor 05:38:22 INFO - Successfully installed mozsystemmonitor 05:38:22 INFO - Cleaning up... 05:38:22 INFO - Return code: 0 05:38:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:38:22 INFO - Using env: {'DISPLAY': ':0', 05:38:22 INFO - 'HOME': '/home/cltbld', 05:38:22 INFO - 'LANG': 'en_US.UTF-8', 05:38:22 INFO - 'LANGUAGE': 'en_US:en', 05:38:22 INFO - 'LOGNAME': 'cltbld', 05:38:22 INFO - 'MAIL': '/var/mail/cltbld', 05:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:22 INFO - 'MOZ_NO_REMOTE': '1', 05:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:22 INFO - 'NO_EM_RESTART': '1', 05:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:22 INFO - 'PWD': '/builds/slave/test', 05:38:22 INFO - 'SHELL': '/bin/bash', 05:38:22 INFO - 'SHLVL': '1', 05:38:22 INFO - 'TERM': 'linux', 05:38:22 INFO - 'TMOUT': '86400', 05:38:22 INFO - 'USER': 'cltbld', 05:38:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:22 INFO - '_': '/tools/buildbot/bin/python'} 05:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:25 INFO - warning: no files found matching '*.txt' 05:38:25 INFO - no previously-included directories found matching 'build' 05:38:25 INFO - no previously-included directories found matching 'dist' 05:38:25 INFO - no previously-included directories found matching '.git*' 05:38:25 INFO - Installing collected packages: jsonschema, functools32 05:38:25 INFO - Running setup.py install for functools32 05:38:25 INFO - warning: no files found matching '*.txt' 05:38:25 INFO - no previously-included directories found matching 'build' 05:38:25 INFO - no previously-included directories found matching 'dist' 05:38:25 INFO - no previously-included directories found matching '.git*' 05:38:25 INFO - Successfully installed jsonschema functools32 05:38:25 INFO - Cleaning up... 05:38:25 INFO - Return code: 0 05:38:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38: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 blobuploader==1.2.4 05:38:25 INFO - Using env: {'DISPLAY': ':0', 05:38:25 INFO - 'HOME': '/home/cltbld', 05:38:25 INFO - 'LANG': 'en_US.UTF-8', 05:38:25 INFO - 'LANGUAGE': 'en_US:en', 05:38:25 INFO - 'LOGNAME': 'cltbld', 05:38:25 INFO - 'MAIL': '/var/mail/cltbld', 05:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:25 INFO - 'MOZ_NO_REMOTE': '1', 05:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:25 INFO - 'NO_EM_RESTART': '1', 05:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:25 INFO - 'PWD': '/builds/slave/test', 05:38:25 INFO - 'SHELL': '/bin/bash', 05:38:25 INFO - 'SHLVL': '1', 05:38:25 INFO - 'TERM': 'linux', 05:38:25 INFO - 'TMOUT': '86400', 05:38:25 INFO - 'USER': 'cltbld', 05:38:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:25 INFO - '_': '/tools/buildbot/bin/python'} 05:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:28 INFO - Downloading docopt-0.6.1.tar.gz 05:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:28 INFO - Running setup.py install for blobuploader 05:38:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:28 INFO - Running setup.py install for requests 05:38:28 INFO - Running setup.py install for docopt 05:38:28 INFO - Successfully installed blobuploader requests docopt 05:38:28 INFO - Cleaning up... 05:38:28 INFO - Return code: 0 05:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:28 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:28 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 05:38:28 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 05:38:28 INFO - Using env: {'DISPLAY': ':0', 05:38:28 INFO - 'HOME': '/home/cltbld', 05:38:28 INFO - 'LANG': 'en_US.UTF-8', 05:38:28 INFO - 'LANGUAGE': 'en_US:en', 05:38:28 INFO - 'LOGNAME': 'cltbld', 05:38:28 INFO - 'MAIL': '/var/mail/cltbld', 05:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:28 INFO - 'MOZ_NO_REMOTE': '1', 05:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:28 INFO - 'NO_EM_RESTART': '1', 05:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:28 INFO - 'PWD': '/builds/slave/test', 05:38:28 INFO - 'SHELL': '/bin/bash', 05:38:28 INFO - 'SHLVL': '1', 05:38:28 INFO - 'TERM': 'linux', 05:38:28 INFO - 'TMOUT': '86400', 05:38:28 INFO - 'USER': 'cltbld', 05:38:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:28 INFO - '_': '/tools/buildbot/bin/python'} 05:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:29 INFO - Running setup.py (path:/tmp/pip-BUzKxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:29 INFO - Running setup.py (path:/tmp/pip-rmbXZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:29 INFO - Running setup.py (path:/tmp/pip-uOGfqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:29 INFO - Running setup.py (path:/tmp/pip-vJkE8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:29 INFO - Running setup.py (path:/tmp/pip-QxtrfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:29 INFO - Running setup.py (path:/tmp/pip-UYFQc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:29 INFO - Running setup.py (path:/tmp/pip-5GF_fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:29 INFO - Running setup.py (path:/tmp/pip-Ixy3YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:29 INFO - Running setup.py (path:/tmp/pip-WjH_8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:29 INFO - Running setup.py (path:/tmp/pip-2AYw61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:29 INFO - Running setup.py (path:/tmp/pip-quFELu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:29 INFO - Running setup.py (path:/tmp/pip-FdlJ5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:30 INFO - Running setup.py (path:/tmp/pip-chgn4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:30 INFO - Running setup.py (path:/tmp/pip-hNjR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:30 INFO - Running setup.py (path:/tmp/pip-qVCf6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:30 INFO - Running setup.py (path:/tmp/pip-wgSUtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:30 INFO - Running setup.py (path:/tmp/pip-qKe2cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:30 INFO - Running setup.py install for manifestparser 05:38:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:30 INFO - Running setup.py install for mozcrash 05:38:30 INFO - Running setup.py install for mozdebug 05:38:30 INFO - Running setup.py install for mozdevice 05:38:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:30 INFO - Running setup.py install for mozfile 05:38:30 INFO - Running setup.py install for mozhttpd 05:38:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozinfo 05:38:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozInstall 05:38:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozleak 05:38:31 INFO - Running setup.py install for mozlog 05:38:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for moznetwork 05:38:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozprocess 05:38:31 INFO - Running setup.py install for mozprofile 05:38:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozrunner 05:38:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:31 INFO - Running setup.py install for mozscreenshot 05:38:31 INFO - Running setup.py install for moztest 05:38:32 INFO - Running setup.py install for mozversion 05:38:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:32 INFO - Cleaning up... 05:38:32 INFO - Return code: 0 05:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:32 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')]} 05:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:32 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')]} 05:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:32 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:32 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 05:38:32 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 05:38:32 INFO - Using env: {'DISPLAY': ':0', 05:38:32 INFO - 'HOME': '/home/cltbld', 05:38:32 INFO - 'LANG': 'en_US.UTF-8', 05:38:32 INFO - 'LANGUAGE': 'en_US:en', 05:38:32 INFO - 'LOGNAME': 'cltbld', 05:38:32 INFO - 'MAIL': '/var/mail/cltbld', 05:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:32 INFO - 'MOZ_NO_REMOTE': '1', 05:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:32 INFO - 'NO_EM_RESTART': '1', 05:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:32 INFO - 'PWD': '/builds/slave/test', 05:38:32 INFO - 'SHELL': '/bin/bash', 05:38:32 INFO - 'SHLVL': '1', 05:38:32 INFO - 'TERM': 'linux', 05:38:32 INFO - 'TMOUT': '86400', 05:38:32 INFO - 'USER': 'cltbld', 05:38:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:32 INFO - '_': '/tools/buildbot/bin/python'} 05:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:32 INFO - Running setup.py (path:/tmp/pip-cyiw7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:32 INFO - Running setup.py (path:/tmp/pip-NbBUzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:32 INFO - Running setup.py (path:/tmp/pip-9edlXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:32 INFO - Running setup.py (path:/tmp/pip-jgjpsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:32 INFO - Running setup.py (path:/tmp/pip-g61PHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:32 INFO - Running setup.py (path:/tmp/pip-B1egpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:32 INFO - Running setup.py (path:/tmp/pip-JeFAuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:32 INFO - Running setup.py (path:/tmp/pip-chflqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:32 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)) 05:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:32 INFO - Running setup.py (path:/tmp/pip-AYDOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:33 INFO - Running setup.py (path:/tmp/pip-GaJO3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:33 INFO - Running setup.py (path:/tmp/pip-BQ2v8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:33 INFO - Running setup.py (path:/tmp/pip-3OZxSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:33 INFO - Running setup.py (path:/tmp/pip-lQxjVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:33 INFO - Running setup.py (path:/tmp/pip-Wdlty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:33 INFO - Running setup.py (path:/tmp/pip-2pyxiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:33 INFO - Running setup.py (path:/tmp/pip-_EXDpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:33 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)) 05:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:33 INFO - Running setup.py (path:/tmp/pip-fOPRIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:33 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)) 05:38:33 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)) 05:38:33 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)) 05:38:33 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)) 05:38:33 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)) 05:38:33 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)) 05:38:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:35 INFO - Downloading blessings-1.6.tar.gz 05:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:35 INFO - Installing collected packages: blessings 05:38:35 INFO - Running setup.py install for blessings 05:38:35 INFO - Successfully installed blessings 05:38:35 INFO - Cleaning up... 05:38:35 INFO - Return code: 0 05:38:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:36 INFO - Reading from file tmpfile_stdout 05:38:36 INFO - Current package versions: 05:38:36 INFO - argparse == 1.2.1 05:38:36 INFO - blessings == 1.6 05:38:36 INFO - blobuploader == 1.2.4 05:38:36 INFO - docopt == 0.6.1 05:38:36 INFO - functools32 == 3.2.3-2 05:38:36 INFO - jsonschema == 2.5.1 05:38:36 INFO - manifestparser == 1.1 05:38:36 INFO - mozInstall == 1.12 05:38:36 INFO - mozcrash == 0.17 05:38:36 INFO - mozdebug == 0.1 05:38:36 INFO - mozdevice == 0.48 05:38:36 INFO - mozfile == 1.2 05:38:36 INFO - mozhttpd == 0.7 05:38:36 INFO - mozinfo == 0.9 05:38:36 INFO - mozleak == 0.1 05:38:36 INFO - mozlog == 3.2 05:38:36 INFO - moznetwork == 0.27 05:38:36 INFO - mozprocess == 0.23 05:38:36 INFO - mozprofile == 0.28 05:38:36 INFO - mozrunner == 6.12 05:38:36 INFO - mozscreenshot == 0.1 05:38:36 INFO - mozsystemmonitor == 0.3 05:38:36 INFO - moztest == 0.7 05:38:36 INFO - mozversion == 1.4 05:38:36 INFO - psutil == 3.1.1 05:38:36 INFO - requests == 1.2.3 05:38:36 INFO - wsgiref == 0.1.2 05:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:36 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')]} 05:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:36 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')]} 05:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:36 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:36 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 05:38:36 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 05:38:36 INFO - Using env: {'DISPLAY': ':0', 05:38:36 INFO - 'HOME': '/home/cltbld', 05:38:36 INFO - 'LANG': 'en_US.UTF-8', 05:38:36 INFO - 'LANGUAGE': 'en_US:en', 05:38:36 INFO - 'LOGNAME': 'cltbld', 05:38:36 INFO - 'MAIL': '/var/mail/cltbld', 05:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:36 INFO - 'MOZ_NO_REMOTE': '1', 05:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:36 INFO - 'NO_EM_RESTART': '1', 05:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:36 INFO - 'PWD': '/builds/slave/test', 05:38:36 INFO - 'SHELL': '/bin/bash', 05:38:36 INFO - 'SHLVL': '1', 05:38:36 INFO - 'TERM': 'linux', 05:38:36 INFO - 'TMOUT': '86400', 05:38:36 INFO - 'USER': 'cltbld', 05:38:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:36 INFO - '_': '/tools/buildbot/bin/python'} 05:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 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)) 05:38:36 INFO - Cleaning up... 05:38:36 INFO - Return code: 0 05:38:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:36 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')]} 05:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:36 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')]} 05:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:36 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 0x1171030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1432180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', '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 05:38:36 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 05:38:36 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 05:38:36 INFO - Using env: {'DISPLAY': ':0', 05:38:36 INFO - 'HOME': '/home/cltbld', 05:38:36 INFO - 'LANG': 'en_US.UTF-8', 05:38:36 INFO - 'LANGUAGE': 'en_US:en', 05:38:36 INFO - 'LOGNAME': 'cltbld', 05:38:36 INFO - 'MAIL': '/var/mail/cltbld', 05:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:36 INFO - 'MOZ_NO_REMOTE': '1', 05:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:36 INFO - 'NO_EM_RESTART': '1', 05:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:36 INFO - 'PWD': '/builds/slave/test', 05:38:36 INFO - 'SHELL': '/bin/bash', 05:38:36 INFO - 'SHLVL': '1', 05:38:36 INFO - 'TERM': 'linux', 05:38:36 INFO - 'TMOUT': '86400', 05:38:36 INFO - 'USER': 'cltbld', 05:38:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:36 INFO - '_': '/tools/buildbot/bin/python'} 05:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:38:36 INFO - Cleaning up... 05:38:36 INFO - Return code: 0 05:38:36 INFO - Running post-action listener: _resource_record_post_action 05:38:36 INFO - Running post-action listener: _start_resource_monitoring 05:38:36 INFO - Starting resource monitoring. 05:38:36 INFO - ##### 05:38:36 INFO - ##### Finished create-virtualenv step (success) 05:38:36 INFO - ##### 05:38:36 INFO - ##### 05:38:36 INFO - ##### Running install step. 05:38:36 INFO - ##### 05:38:36 INFO - Running pre-action listener: _resource_record_pre_action 05:38:36 INFO - Running main action method: install 05:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:36 INFO - Reading from file tmpfile_stdout 05:38:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:36 INFO - Reading from file tmpfile_stdout 05:38:36 INFO - Output received: 05:38:36 INFO - Usage: mozinstall [options] installer 05:38:36 INFO - Options: 05:38:36 INFO - -h, --help show this help message and exit 05:38:36 INFO - -d DEST, --destination=DEST 05:38:36 INFO - Directory to install application into. [default: 05:38:36 INFO - "/builds/slave/test"] 05:38:36 INFO - --app=APP Application being installed. [default: firefox] 05:38:36 INFO - mkdir: /builds/slave/test/build/application 05:38:36 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'] 05:38:36 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 05:38:53 INFO - Reading from file tmpfile_stdout 05:38:53 INFO - Output received: 05:38:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:38:53 INFO - Running post-action listener: _resource_record_post_action 05:38:53 INFO - ##### 05:38:53 INFO - ##### Finished install step (success) 05:38:53 INFO - ##### 05:38:53 INFO - ##### 05:38:53 INFO - ##### Running run-tests step. 05:38:53 INFO - ##### 05:38:53 INFO - Running pre-action listener: _resource_record_pre_action 05:38:53 INFO - Running main action method: run_tests 05:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:53 INFO - Python 2.7.3 05:38:53 INFO - Return code: 0 05:38:53 INFO - grabbing minidump binary from tooltool 05:38:53 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')]} 05:38:53 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 0x14303b0>, '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 0x14312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:53 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 05:38:53 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 05:38:53 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 05:38:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:53 INFO - Return code: 0 05:38:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:38:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:38:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:53 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/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 05:38:53 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/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 05:38:53 INFO - Using env: {'DISPLAY': ':0', 05:38:53 INFO - 'HOME': '/home/cltbld', 05:38:53 INFO - 'LANG': 'en_US.UTF-8', 05:38:53 INFO - 'LANGUAGE': 'en_US:en', 05:38:53 INFO - 'LOGNAME': 'cltbld', 05:38:53 INFO - 'MAIL': '/var/mail/cltbld', 05:38:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:53 INFO - 'MOZ_NO_REMOTE': '1', 05:38:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:53 INFO - 'NO_EM_RESTART': '1', 05:38:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:53 INFO - 'PWD': '/builds/slave/test', 05:38:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:53 INFO - 'SHELL': '/bin/bash', 05:38:53 INFO - 'SHLVL': '1', 05:38:53 INFO - 'TERM': 'linux', 05:38:53 INFO - 'TMOUT': '86400', 05:38:53 INFO - 'USER': 'cltbld', 05:38:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796', 05:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:53 INFO - '_': '/tools/buildbot/bin/python'} 05:38:53 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/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 05:38:53 INFO - mozversion application_buildid: 20160708031827 05:38:53 INFO - mozversion application_changeset: 00b612e67c091e3e5899fe5e8a60870ed1a910f2 05:38:53 INFO - mozversion application_display_name: Nightly 05:38:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:53 INFO - mozversion application_name: Firefox 05:38:53 INFO - mozversion application_remotingname: firefox 05:38:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:38:53 INFO - mozversion application_vendor: Mozilla 05:38:53 INFO - mozversion application_version: 50.0a1 05:38:53 INFO - mozversion platform_buildid: 20160708031827 05:38:53 INFO - mozversion platform_changeset: 00b612e67c091e3e5899fe5e8a60870ed1a910f2 05:38:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:38:53 INFO - mozversion platform_version: 50.0a1 05:38:53 INFO - using testdate: 1467981533 05:38:53 INFO - actual date: 1467981533 05:38:53 INFO - starting webserver on 'localhost:59850' 05:38:53 INFO - SUITE-START | Running 2 tests 05:38:53 INFO - TEST-START | dromaeo_css 05:38:53 INFO - operating with platform_type : linux_ 05:38:53 INFO - Initialising browser for dromaeo_css test... 05:38:53 INFO - TEST-INFO | started process 11222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIYAl8/profile http://localhost:59850/getInfo.html) 05:38:57 INFO - PROCESS | 11222 | __metrics Screen width/height:1600/1200 05:38:57 INFO - PROCESS | 11222 | colorDepth:24 05:38:57 INFO - PROCESS | 11222 | Browser inner width/height: 1024/697 05:38:57 INFO - PROCESS | 11222 | __metrics 05:38:58 INFO - PROCESS | 11222 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:59 INFO - TEST-INFO | 11222: exit 0 05:38:59 INFO - Browser initialized. 05:38:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:59 INFO - TEST-INFO | started process 11304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIYAl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:11 INFO - PROCESS | 11304 | RSS: Main: 158789632 05:39:11 INFO - PROCESS | 11304 | 05:40:03 INFO - PROCESS | 11304 | 1467981603512 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] 05:42:15 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59850/tests/dromaeo/cssquery-ext.html) 05:42:17 INFO - PROCESS | 11304 | RSS: Main: 249528320 05:42:17 INFO - PROCESS | 11304 | 05:45:19 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-ext.html (next: http://localhost:59850/tests/dromaeo/cssquery-jquery.html) 05:45:20 INFO - PROCESS | 11304 | RSS: Main: 247152640 05:45:20 INFO - PROCESS | 11304 | 05:48:22 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59850/tests/dromaeo/cssquery-mootools.html) 05:48:23 INFO - PROCESS | 11304 | RSS: Main: 243793920 05:48:23 INFO - PROCESS | 11304 | 05:51:25 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59850/tests/dromaeo/cssquery-prototype.html) 05:51:25 INFO - PROCESS | 11304 | RSS: Main: 237203456 05:51:25 INFO - PROCESS | 11304 | 05:54:28 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59850/tests/dromaeo/cssquery-yui.html) 05:54:29 INFO - PROCESS | 11304 | RSS: Main: 218525696 05:54:29 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-yui.html (next: http://localhost:59850/tests/dromaeo/cssquery-dojo.html) 05:57:32 INFO - PROCESS | 11304 | RSS: Main: 279289856 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | __start_tp_report 05:57:32 INFO - PROCESS | 11304 | _x_x_mozilla_page_load 05:57:32 INFO - PROCESS | 11304 | _x_x_mozilla_page_load_details 05:57:32 INFO - PROCESS | 11304 | |i|pagename|runs| 05:57:32 INFO - PROCESS | 11304 | |0;dojo.html;2632.842029478231;2641.339665083729;2667.30650030992;2670.853103079331;2681.3162643525898;4624.560666736663;4693.003901689401;4708.199606066968;4759.167145749489;4813.037392521496;4685.4143232095985;4738.881527961803;4743.5256474352545;4748.667593268473;4765.547273009067;4314.050908800059;4341.196878577458;4368.759718215497;4373.322135069069;4390.385346051556;4362.1275744851155;4423.491298500665;4448.421705178338;4462.263726485142;4507.211238033347;4406.955930440687;4456.9331460028125;4458.041521072969;4464.575865292808;4494.505604383531;4297.054647977471;4319.049809042006;4359.04101097758;4369.912601747979;4391.231534481453;4324.113556720865;4353.499347575038;4354.499232588261;4361.825526978917;4422.248217802981;4767.094252092092;4786.8085276589245;4797.136515427222;4804.087223427572;4836.056968891067;4885.487023862479;4983.750812459362;5165.535101840815;5174.586033117379;5186.611004174664;5114.053900028507;5150.201718733602;5188.11801993662;5191.065608190562;5203.635745497817;4756.21522448799;4804.711717296974;4806.086843499724;4829.154897892855;4840.128776820206;5100.413452452941;5216.426193118754;5268.236105764643;5269.736513174403;5317.361916569959;5057.72182529957;5092.388913330424;5102.36220472441;5114.514121158559;5117.078925793393;5144.6655967362;5147.948520514822;5154.8969020620125;5182.326297581366;5204.71374074422;4979.153543897546;5045.84862454127;5073.416557095908;5123.795048198031;5129.333186685782;5097.8215762448135;5098.949010509921;5112.897742045138;5117.334746482933;5121.654139805701;4287.892802679958;4289.721168124062;4289.935650965238;4319.049809042006;4340.9131817364105;3642.1258897864323;3679.043448703303;3706.258748250361;3715.702743780491;3765.4163604641326;4418.779061046935;4420.138073075784;4434.955650443454;4467.597916187558;4476.395686582335;5092.28707980883;5118.25785261135;5135.075686376488;5142.331496905378;5194.948050519522;4282.293421585466;4336.219480493478;4376.540463251376;4383.627391671744;4431.869873182318;4549.567791059844;4556.3165525170825;4556.863294101182;4600.838970636011;4608.216603177468;4875;4876.268559716071;4877.414710234794;4879.756012199305;4925.064237794808;4972.8508144755715;5087.64386492942;5148.407933087743;5157.819476318311;5164.561012313995;4872.123017856819;4885.560299572913;4894.290327902506;4924.359833221658;4939.629527785359;5033.370828646419;5039.143345631325;5040.243963405518;5044.1424957756535;5057.064443078042;4921.975390123026;4992.425871024879;5074.467180945948;5094.847154585368;5154.252633368065;4972.254161875748;4974.726390048438;4985.75071246429;4990.126727822689;4998.725070121178;4950.257461380822;4966.627502937222;4967.503249675004;4967.7516124192925;5018.899622007466;4784.210605250234;4839.975800120977;4890.975545122252;4900.215965445512;4959.132151873336;5022.698638081727;5063.291139240436;5112.667676601009;5116.897662046813;5118.283440318432;4921.188003979303;4926.704397736147;4932.2601609757385;4935.901281974268;4983.25251212321 05:57:32 INFO - PROCESS | 11304 | |1;ext.html;532.6058716549752;534.9304590403249;540.697209562645;583.6964778315277;590.1413443439795;26748.191439898797;38231.23537529251;39663.20673586534;39671.40492892605;43394.78302608483;39281.803590982;39612.60387396132;39736;39796.20407591854;39803.800980995125;7271.236520165386;7567.016287882581;7698.692052317901;7755.418343624223;7758.185390533998;9755.95122024389;10068.647597334095;10069.496525173749;10360.740981475486;10372.066514013737;10108.898911010869;10201.43892085935;10214.080732734052;10217.591296348175;10230.948845255763;7340.082489688789;9835.901640983642;10041.598336066549;10086.596536138546;10116.089551940287;9972.750681232954;10030;10035.648752293635;10035.899641003643;10050.296479246455;38187.618123818684;38394;38424;38518.42222366667;38585.228295434215;2940.2061443410375;2992.58103865459;3001.639803223605;3043.04144194578;3076.2463196516774;28174.295642608893;28370.148895533166;28375.290617734514;28415.821430521893;29137.85431072831;3535.5403797506415;3576.695980841632;3596.334678084537;3627.075095850568;3670.46778217157;251191;253608;253638;253828;253844.73077634678;51149.23276150861;51254.23118653223;51346.74326628343;51750;51804.740976294874;32425.351492970007;33208.83395583055;33639;35409.291814163575;52820;13917.86082139186;14127.64680882986;14133.929330353283;14159.362828672734;14161.645958850904;9363.859542106873;9633.951830240803;10260.127889129508;10564.841527377095;10689.091427228772;17912.820871791377;17935.461936141935;17978.640427191644;18018.819811801975;18098.819011809977;6747.662616869137;6764.898526522106;6964.965175174092;7010.474214433836;7026.15686117659;802.6548584108889;886.6054605700531;907.1925985872579;933.9206167475704;948.4404201521136;27773.166804995883;28317.57523637147;28332.858335708188;28546.143615691562;28554.85722571374;920.7882187096872;930.2929773372285;945.0030218119949;951.6288647427509;996.3225006995168;13773.311334433238;14246.643833904236;14513.927430362992;14644.633884152769;14654.63363415923;396902;401691;401903;402080;403078;46750.766246168554;46921.76539117283;47209.29186062212;47223.76388118038;47383.05233895372;1041.8385150301565;1106.446776611694;1149.5286932357694;1171.7773623011772;1195.935617300603;27933.441331173668;27988.02041928523;29407.705922940495;30053.54919676163;30212.395752085275;43366.783166083966;43953.56046439495;44042.779786100866;44108;44214.336784947605;358316;365243;365438;365534;366962;31149.844250778602;39093.2181356377;39494.80252598719;39682.40476392914;42051.7897410511;39305.213895722496;42894.57105428906;42924;43561.56438435702;43806.12387752291;36396.27207455783;36962.8151859239;37163.81418092892;37422.25155496929;37906.346555740834;37060.62939370572;37211.25577488489;37487;37623.24753504969;41226;31302;31350.216244593154;32067.518987215677;32113.357732844746;32147.196320092185;33156.33687326288;33869.491957620165;34347.14132146716;34377.484337735455;34774.82612586921;25733.3566660835;26115.477690445703;26224;26230;26756 05:57:32 INFO - PROCESS | 11304 | |2;jquery.html;371.3575514360157;374.87816459650605;378.1472778883617;384.5385537355171;385.5643123270705;16550.751738723913;17677.82322176778;17766.91116544417;18634.81365186348;18654.253829846806;14690.192039437827;14732.410703571844;14992.400303987828;15027.549173524785;15034.849651503482;5056.620753443497;5221.895562088756;5260.737423018486;5263.34208223972;5263.684178949256;3764.755290906096;3947.2697550953167;5074.923876141861;5692.601517893749;5993.670348130851;5965.284165900076;5985.431384018533;5989.760409583611;5991.970040149793;5993.730282137314;5795.913061304083;6103.29812071613;6103.877922441548;6113.969430152865;6119.143319935212;3386.86452541898;5070.112730272188;5343.118385466393;5352.705601191933;5377.75800088993;18001.279948802032;18034.36879709217;18994.810051899443;22598;22604.095836166533;2338.5089131282452;2572.4212052288085;2573.704024037222;2576.0854896511655;2576.6263891735593;13848.446062157502;13875.167489950636;13885.861141388557;13956.441742330295;14004.369803358772;1779.5729025034027;1834.4955137337206;1848.3068849181557;1856.0348618718326;1913.9043047847551;67436;68669.3133068668;69315.3068469319;69812.30187698109;71388.64305678438;9640.75898102553;9661.275404344702;10185;10199.745006374751;10290.536925838205;13738.381772820247;13848.515301964382;13848.930755346159;13865;13888.722225555432;6937.340952609494;7079.115110611174;7091.6454177290925;7122.679479423438;7133.500654954103;6489.70796314167;6514.3811337922825;6527.771527996498;6617.7683781067435;6632.900506492407;6324.873502529924;6324.968375158095;6358.586691865014;6367.586106903036;6384.936150638527;1533.5935976966114;1585.5243426971863;1743.2068408873931;1773.3438627707574;1783.8572914166834;771.5370777533435;812.5937031484258;826.2357319479457;830.8961379827522;905.9637614495479;15834.28745706446;15945.760813587805;16403.5899102521;16443;16635.584110397336;839.8572242718752;847.3009766942297;851.923326900582;906.5829718329642;912.5346073502561;9500.48237217138;9883.604655813831;10045.19638428924;10103.797924041624;10167.593296268215;364052.5163238548;366030;367974;375009;379747.70883019513;68170.65914670494;68865.3113468869;70192;70672.64663676648;71393;879.4942907827897;880.5377176982007;908.246155690775;909.9636014559476;910.8952470465849;14992;15112.697746045238;15124.470643527864;15269.236538172825;15533.378664853732;34694.82652586721;35249.64750352566;35430.64569354377;35539;35868;48942.953941033345;56541.71729141328;57369;57779.4222057774;58115.70942145431;7344.934984427335;8021.63902624395;8047.396445266511;10832.837507437553;11335;12189.634310970685;12329.691757706129;12500.687482812638;12683.175593586388;12850.871491284968;11404.714882128013;11423.200375973602;11479.540818367172;11534.653960381202;11577.6526704199;11365.204435689422;11506.94246528762;11587.073034157078;11851.525938962344;12045;11349.546018159512;11512.942435288105;11678;11829.231099978473;11842.348670823187;11770.94114529456;12000;12024.699382515508;12073.154879158375;12083.39583020863;11178.496967636313;11294.322340659586;11336.14978876604;11494.54021839117;11518.712032199262 05:57:32 INFO - PROCESS | 11304 | |3;mootools.html;1321.194071616314;1367.7811550151976;1422.2391020803873;1673.4814104772315;1693.212656114907;7451.403887688985;7896.842063158733;7956;7958.323542498894;7962.522248665077;6665.43343815775;7120.359167674908;7319.414446844253;7319.9268007319915;7764.223577642247;2165.231342873277;2180.738311402634;2183.4323076000273;2192.419008962618;2193.144673577306;1862.0782712557302;2096.4549217203485;2103.57928414317;2110.2297661353573;2113.968290475644;2133.1467413034834;2219.4562332228625;2225.666150077493;2239.8992045358;2240.6526988316755;2204.0522575292616;2204.1183526589334;2206.801387875083;2216.445888527868;2227.5544891021777;2059.783722709109;2065.834733221354;2066.214838361428;2067.1937944201773;2090.8850013249266;7781.922180778233;7903.288704016666;7909.7231596893835;7914.3272821810215;7918;4378.343248512717;4455.376247325345;4485.618722408599;4486.685931984763;4490.685652004361;2724.5368287391193;2804;2849.33040735427;2849.4443583501225;2855.4003659231585;894.3292530602048;895.6283142495856;900.8108297257584;917.6650522559285;940.8917974432959;10376.79246415075;10456.895431045668;10463.372197668165;10488.108510776518;10496.842547361872;4052.6352628263007;4190.832366705297;4327.870163895088;4334.8266069357505;4350.891227719269;9000.549972501349;9044.592993315317;9051.230645395215;9062.864057039149;9062.954685226532;4692.225782745809;4692.7653617319;4699.036697477009;4703.106409782131;4705.694129881546;4173.624373806372;4177.436046133733;4280.400743895857;4289.571042895748;4294.527601963781;3649.233660931181;3704.981475092661;3715.64701353371;3753.9061523461587;3761.2665530221893;1072.158355690779;1157.7973854575584;1174.4127936031985;1183.4674396521427;1196.0790191552455;679.9320067993161;771.5872008475438;805.9032916049995;817.1215942861447;837.1753822484848;5074.619403544675;5186.533212010937;5272.2882410874045;5290.867728306746;5354.9464505354445;826.3059030414361;853.3130829682166;863.8747381629629;904.0597778310615;908.2234689340651;3429.5198672185916;3632.8365223565;3653.5433070866143;3658.4512323151207;3727.459518369821;8908.643654253758;9112.043235460182;9151.17639412456;9155.13026262504;9166.175044245916;8284.461510001951;8859.11408859122;9039.23166530839;9070.047644997312;9313.20837728787;7113.466490013167;7300;7306.890396643948;7317.085364329459;7319.194888562254;5356.7589458473685;5357.276767636319;5390.676559406291;5495.780168793363;5536.031194541019;8777.078406767198;8994.910050899669;9009.144131307516;9015.188633022797;9015.549222538715;8845.159709827556;8984.011758706407;8994.235489983424;9113.36206465541;9255.167034966616;6822.181338239443;6864.622445765531;6886.24251332363;6886.414654754201;6897.137857767779;7048.189458212166;7225.24134965821;7235.674394652358;7242.493025488166;7243.674034668347;5156.4327923927585;6627.4698024158915;6656.667166641551;6682.365175308338;6939.826504337432;6302.243730752339;6654.83362915931;6690.899636505554;6763.12079429671;6840.965795170992;6206.565540412128;6255.874882502233;6278.058291256348;6281.277653069773;6284.245890492987;4411.9558804411545;4475.194464996332;4488.775561221861;4605.976970115128;4608.3778689876435;4535.614472769851;4569.246074397687;4577.130345234395;4632.189366860718;4700.365450664253 05:57:32 INFO - PROCESS | 11304 | |4;prototype.html;304.6024937456619;309.5913394319499;314.87090292979883;316.16847690573786;316.7291965369607;4882.365292511973;4889.8533044008645;4909.950900490994;4911.410630724309;4914.2137258038765;4860.8541743747655;4863.246196839486;4869.784248167084;4878.317035615008;4889.559939605435;3653.5433070866143;3730.7874940644265;3785.829637666298;3867.0719027433356;3902.180542086165;3839.1745774658443;3842.3083844907906;3880.068783491956;3926.509186351706;3928.8428462861452;3801.752886062397;3837.328467518187;3845.42318652203;3856.055266459721;3860.4402361657544;3601.94597081044;3648.3797754381685;3775.716821238391;3780.4878048780433;3787.822002348633;3333.683300086488;3333.783304085251;3341.4319565673895;3341.448660970937;3345.933081338384;4777.832775852863;4798.880027999293;4801.8079276828885;4803.351547541072;4807.423109226916;4236.964994032802;4343.522212556616;4343.956560434387;4369.388285640013;4405.757683327416;5022.949770502285;5047.268146118792;5050.671706339076;5057.216131499624;5080.974595127001;3699.038250054978;3700.204456041937;3703.4815125882396;3722.553293604785;3730.2166545025575;5201;5257.79172747447;5289.365276166846;5293.285406470154;5334.946650533484;3794.317022935843;3811.4092315691114;3812.3328417526823;3813.9809300953316;3826.2730081284467;3854.421836724514;3856.2480316338047;3858.6913046956174;3858.7684738915755;3859.5368555772925;4324.481062272547;4349.869503914824;4350.282203436397;4381.539938306496;4385.890352741143;4875.585575226146;5056.924146137811;5062.4684408137355;5066.16408292635;5068.290439338495;1321.4251800466636;1326.2109045118139;1329.1692692067459;1329.288830475691;1333.7999300105062;867.3754896474528;872.5506364222431;885.1369914333602;896.8430524658158;914.3553794574809;4469.664775141878;4480.417545719036;4487.259602165606;4496.4154659894;4501.842435514741;5193.766280517386;5198.454162312978;5200.349956255468;5207.3751149862255;5210.400803907523;4317.114991426813;4414.713043652152;4467.419235499429;4472.39622650938;4487.326900964881;2747.6565429321336;2754.931126721848;2773.1541879726474;2774.8473833938924;2785.206216228365;4901.36282283308;4928.852134435972;4935.716713654404;4962.60299176065;4975.776090075955;5117.360329958755;5342.54588359986;5346.946530534723;5360.311501876897;5474;5026.874328141826;5049.924251136236;5058.58359659296;5062.240663900445;5062.265971434122;5286.101362768261;5307.974454561017;5323.494268044529;5329.120695085423;5335.493128152819;5041.369828771403;5237.214417837355;5242.921356179737;5245.423003469692;5245.868853278546;5005.299258103795;5017.523335283142;5032.043911656773;5036.575128912375;5067.949320506747;3762.435634654824;3795.8291876865055;3808.4477750725437;3810.6379893910034;3812.5234345706785;5171.991461664939;5323.987398964534;5336.226247194213;5363.436839131991;5365.704886231295;5121.487851214849;5148.2020286855595;5149.150390185578;5149.459306772735;5167.689938603696;5123.87190320245;5127.79488820443;5139.691618502902;5172.224166375074;5178.394697643743;4950.2079667253065;5078.206986157525;5084.211947148198;5109.46350633193;5123.513266239701;4929.767558110472;5012.273220383097;5173.534381905646;5177.974110129425;5183.8487027883;5005.947561499767;5014.57376123019;5041.428871275749;5055.216441451581;5084.440711521655 05:57:32 INFO - PROCESS | 11304 | |5;yui.html;621.8383220362707;636.6466611030877;637.2194062273712;701.8666453373856;727.0330460487552;13528.323583820806;14147.858521414782;14154.71690566188;14155.787663185034;14158.362873670683;12649.430775615096;12989.48042078318;13169.802452963213;13618.591442256724;13653;772.6329993253202;789.3211837819499;793.9444238903279;793.9682412703485;794.3883209928351;615.3723202333639;763.5037225803245;766.7239793674273;769.7690692792168;785.7956931197901;682.5051837417857;686.4268335939496;687.9415249703782;688.6556721639181;698.354022529161;707.1937990690617;714.5105602662142;716.4268585131925;719.3094629156017;720.2653293640484;471.4578235029709;473.00668595948576;482.6959015820011;484.06816877511005;579.1775678536488;13548.45806167752;14212.218327991955;14246.501372452018;14250.714985700331;14254.14475131485;11739.941300293529;12651;12763.234205947672;12879.87120128796;13053.934730326382;11990.400479975966;12023.458944347438;12134.089943254203;12321.075919306088;12343.93828030863;4134.462519872427;4149.875503734893;4154.1068670235745;4172.687048471377;4224;69363.65318173377;70035.94946075813;70154;70419;70768;10320.587176512856;10331.652299207542;10413.42726150069;10443.530041148166;10488.842667359995;17894.194761235776;17915.73126403105;17919.641607167785;17924.641507170043;17931.910340448216;6676.399124078856;6746.325367463312;6760.594364338155;6837.555558888656;6900.723971041102;3663.3405986922608;3708.128589781399;3746.4193050077283;3800.809959502014;3812.275667623143;2736.50742866282;2797.398559309758;2813.887444502238;2832.929176770597;2838.233676907265;486.2390359088016;489.6058672768456;496.5704665464347;497.16972655665126;498.12081675842165;470.6940488682384;479.4510285722898;502.38708775294083;506.29624821498146;538.1148011521026;7254.782356529313;7320.15818180916;7335.926640733631;7649.426293027934;7911.76264712048;412.8080442594208;470.5858844217067;492.0847224163054;504.6316189181844;528.0916823064323;3552.5381700378784;3606.6290437962152;3742.5883152853166;3842.028862605847;3854.2676891390547;99628.04463464285;108137.45931270294;108370;109164.4541777286;109495.45252273687;95887;96371.51814240884;97126;97530.51234743923;98078.5096074515;58707.70646146742;78655.60672196717;82742;84940.15059849447;85123.76448001865;7162;7372.815679607838;7412.295831895961;7413.221611730906;7450.36671882896;46274.87642595;48072.7596362016;48834;49746.00507989748;49980.75240594926;43071.56928430676;67433;69568.30431695821;71314;71476.64261678659;9106.362554621113;9215;9271.953640232026;9327.580258888502;9423.764405889908;10201.591936322464;10205;10295.53670084863;11896.167268291136;12298.508059677513;10043.246756493147;10136.949315253376;10170.237232207466;11198.496067677137;12073.335966521925;12513.562025329435;13114.803277950648;13140.145890517086;13151.53969611059;13336.866631333562;10341.586336546454;10386.740331491774;10565.788684226427;10998.285111467729;11082.390468524309;10381.84427233577;10650.73373165677;10887.18346124028;10923.289986150874;11048;9768.316217864682;9834.360766550151;9969.152622027208;10296.897031029594;10329.328593641389 05:57:32 INFO - PROCESS | 11304 | __end_tp_report 05:57:32 INFO - PROCESS | 11304 | __start_cc_report 05:57:32 INFO - PROCESS | 11304 | _x_x_mozilla_cycle_collect,1192 05:57:32 INFO - PROCESS | 11304 | __end_cc_report 05:57:32 INFO - PROCESS | 11304 | __startTimestamp1467982652646__endTimestamp 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | ------- Summary: start ------- 05:57:32 INFO - PROCESS | 11304 | Number of tests: 6 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#0] dojo.html Cycles:165 Average:4726.74 Median:4885.49 stddev:507.68 (10.4%) stddev-sans-first:481.93 05:57:32 INFO - PROCESS | 11304 | Values: 2632.8 2641.3 2667.3 2670.9 2681.3 4624.6 4693.0 4708.2 4759.2 4813.0 4685.4 4738.9 4743.5 4748.7 4765.5 4314.1 4341.2 4368.8 4373.3 4390.4 4362.1 4423.5 4448.4 4462.3 4507.2 4407.0 4456.9 4458.0 4464.6 4494.5 4297.1 4319.0 4359.0 4369.9 4391.2 4324.1 4353.5 4354.5 4361.8 4422.2 4767.1 4786.8 4797.1 4804.1 4836.1 4885.5 4983.8 5165.5 5174.6 5186.6 5114.1 5150.2 5188.1 5191.1 5203.6 4756.2 4804.7 4806.1 4829.2 4840.1 5100.4 5216.4 5268.2 5269.7 5317.4 5057.7 5092.4 5102.4 5114.5 5117.1 5144.7 5147.9 5154.9 5182.3 5204.7 4979.2 5045.8 5073.4 5123.8 5129.3 5097.8 5098.9 5112.9 5117.3 5121.7 4287.9 4289.7 4289.9 4319.0 4340.9 3642.1 3679.0 3706.3 3715.7 3765.4 4418.8 4420.1 4435.0 4467.6 4476.4 5092.3 5118.3 5135.1 5142.3 5194.9 4282.3 4336.2 4376.5 4383.6 4431.9 4549.6 4556.3 4556.9 4600.8 4608.2 4875.0 4876.3 4877.4 4879.8 4925.1 4972.9 5087.6 5148.4 5157.8 5164.6 4872.1 4885.6 4894.3 4924.4 4939.6 5033.4 5039.1 5040.2 5044.1 5057.1 4922.0 4992.4 5074.5 5094.8 5154.3 4972.3 4974.7 4985.8 4990.1 4998.7 4950.3 4966.6 4967.5 4967.8 5018.9 4784.2 4840.0 4891.0 4900.2 4959.1 5022.7 5063.3 5112.7 5116.9 5118.3 4921.2 4926.7 4932.3 4935.9 4983.3 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#1] ext.html Cycles:180 Average:49150.54 Median:200819.64 stddev:90983.36 (45.3%) stddev-sans-first:91165.37 05:57:32 INFO - PROCESS | 11304 | Values: 532.6 534.9 540.7 583.7 590.1 26748.2 38231.2 39663.2 39671.4 43394.8 39281.8 39612.6 39736.0 39796.2 39803.8 7271.2 7567.0 7698.7 7755.4 7758.2 9756.0 10068.6 10069.5 10360.7 10372.1 10108.9 10201.4 10214.1 10217.6 10230.9 7340.1 9835.9 10041.6 10086.6 10116.1 9972.8 10030.0 10035.6 10035.9 10050.3 38187.6 38394.0 38424.0 38518.4 38585.2 2940.2 2992.6 3001.6 3043.0 3076.2 28174.3 28370.1 28375.3 28415.8 29137.9 3535.5 3576.7 3596.3 3627.1 3670.5 251191.0 253608.0 253638.0 253828.0 253844.7 51149.2 51254.2 51346.7 51750.0 51804.7 32425.4 33208.8 33639.0 35409.3 52820.0 13917.9 14127.6 14133.9 14159.4 14161.6 9363.9 9634.0 10260.1 10564.8 10689.1 17912.8 17935.5 17978.6 18018.8 18098.8 6747.7 6764.9 6965.0 7010.5 7026.2 802.7 886.6 907.2 933.9 948.4 27773.2 28317.6 28332.9 28546.1 28554.9 920.8 930.3 945.0 951.6 996.3 13773.3 14246.6 14513.9 14644.6 14654.6 396902.0 401691.0 401903.0 402080.0 403078.0 46750.8 46921.8 47209.3 47223.8 47383.1 1041.8 1106.4 1149.5 1171.8 1195.9 27933.4 27988.0 29407.7 30053.5 30212.4 43366.8 43953.6 44042.8 44108.0 44214.3 358316.0 365243.0 365438.0 365534.0 366962.0 31149.8 39093.2 39494.8 39682.4 42051.8 39305.2 42894.6 42924.0 43561.6 43806.1 36396.3 36962.8 37163.8 37422.3 37906.3 37060.6 37211.3 37487.0 37623.2 41226.0 31302.0 31350.2 32067.5 32113.4 32147.2 33156.3 33869.5 34347.1 34377.5 34774.8 25733.4 26115.5 26224.0 26230.0 26756.0 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#2] jquery.html Cycles:180 Average:24128.90 Median:35340.15 stddev:61110.55 (172.9%) stddev-sans-first:61255.94 05:57:32 INFO - PROCESS | 11304 | Values: 371.4 374.9 378.1 384.5 385.6 16550.8 17677.8 17766.9 18634.8 18654.3 14690.2 14732.4 14992.4 15027.5 15034.8 5056.6 5221.9 5260.7 5263.3 5263.7 3764.8 3947.3 5074.9 5692.6 5993.7 5965.3 5985.4 5989.8 5992.0 5993.7 5795.9 6103.3 6103.9 6114.0 6119.1 3386.9 5070.1 5343.1 5352.7 5377.8 18001.3 18034.4 18994.8 22598.0 22604.1 2338.5 2572.4 2573.7 2576.1 2576.6 13848.4 13875.2 13885.9 13956.4 14004.4 1779.6 1834.5 1848.3 1856.0 1913.9 67436.0 68669.3 69315.3 69812.3 71388.6 9640.8 9661.3 10185.0 10199.7 10290.5 13738.4 13848.5 13848.9 13865.0 13888.7 6937.3 7079.1 7091.6 7122.7 7133.5 6489.7 6514.4 6527.8 6617.8 6632.9 6324.9 6325.0 6358.6 6367.6 6384.9 1533.6 1585.5 1743.2 1773.3 1783.9 771.5 812.6 826.2 830.9 906.0 15834.3 15945.8 16403.6 16443.0 16635.6 839.9 847.3 851.9 906.6 912.5 9500.5 9883.6 10045.2 10103.8 10167.6 364052.5 366030.0 367974.0 375009.0 379747.7 68170.7 68865.3 70192.0 70672.6 71393.0 879.5 880.5 908.2 910.0 910.9 14992.0 15112.7 15124.5 15269.2 15533.4 34694.8 35249.6 35430.6 35539.0 35868.0 48943.0 56541.7 57369.0 57779.4 58115.7 7344.9 8021.6 8047.4 10832.8 11335.0 12189.6 12329.7 12500.7 12683.2 12850.9 11404.7 11423.2 11479.5 11534.7 11577.7 11365.2 11506.9 11587.1 11851.5 12045.0 11349.5 11512.9 11678.0 11829.2 11842.3 11770.9 12000.0 12024.7 12073.2 12083.4 11178.5 11294.3 11336.1 11494.5 11518.7 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#3] mootools.html Cycles:180 Average:5074.66 Median:5355.85 stddev:2806.48 (52.4%) stddev-sans-first:2800.18 05:57:32 INFO - PROCESS | 11304 | Values: 1321.2 1367.8 1422.2 1673.5 1693.2 7451.4 7896.8 7956.0 7958.3 7962.5 6665.4 7120.4 7319.4 7319.9 7764.2 2165.2 2180.7 2183.4 2192.4 2193.1 1862.1 2096.5 2103.6 2110.2 2114.0 2133.1 2219.5 2225.7 2239.9 2240.7 2204.1 2204.1 2206.8 2216.4 2227.6 2059.8 2065.8 2066.2 2067.2 2090.9 7781.9 7903.3 7909.7 7914.3 7918.0 4378.3 4455.4 4485.6 4486.7 4490.7 2724.5 2804.0 2849.3 2849.4 2855.4 894.3 895.6 900.8 917.7 940.9 10376.8 10456.9 10463.4 10488.1 10496.8 4052.6 4190.8 4327.9 4334.8 4350.9 9000.5 9044.6 9051.2 9062.9 9063.0 4692.2 4692.8 4699.0 4703.1 4705.7 4173.6 4177.4 4280.4 4289.6 4294.5 3649.2 3705.0 3715.6 3753.9 3761.3 1072.2 1157.8 1174.4 1183.5 1196.1 679.9 771.6 805.9 817.1 837.2 5074.6 5186.5 5272.3 5290.9 5354.9 826.3 853.3 863.9 904.1 908.2 3429.5 3632.8 3653.5 3658.5 3727.5 8908.6 9112.0 9151.2 9155.1 9166.2 8284.5 8859.1 9039.2 9070.0 9313.2 7113.5 7300.0 7306.9 7317.1 7319.2 5356.8 5357.3 5390.7 5495.8 5536.0 8777.1 8994.9 9009.1 9015.2 9015.5 8845.2 8984.0 8994.2 9113.4 9255.2 6822.2 6864.6 6886.2 6886.4 6897.1 7048.2 7225.2 7235.7 7242.5 7243.7 5156.4 6627.5 6656.7 6682.4 6939.8 6302.2 6654.8 6690.9 6763.1 6841.0 6206.6 6255.9 6278.1 6281.3 6284.2 4412.0 4475.2 4488.8 4606.0 4608.4 4535.6 4569.2 4577.1 4632.2 4700.4 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#4] prototype.html Cycles:180 Average:4263.10 Median:4885.96 stddev:1230.46 (25.2%) stddev-sans-first:1197.50 05:57:32 INFO - PROCESS | 11304 | Values: 304.6 309.6 314.9 316.2 316.7 4882.4 4889.9 4910.0 4911.4 4914.2 4860.9 4863.2 4869.8 4878.3 4889.6 3653.5 3730.8 3785.8 3867.1 3902.2 3839.2 3842.3 3880.1 3926.5 3928.8 3801.8 3837.3 3845.4 3856.1 3860.4 3601.9 3648.4 3775.7 3780.5 3787.8 3333.7 3333.8 3341.4 3341.4 3345.9 4777.8 4798.9 4801.8 4803.4 4807.4 4237.0 4343.5 4344.0 4369.4 4405.8 5022.9 5047.3 5050.7 5057.2 5081.0 3699.0 3700.2 3703.5 3722.6 3730.2 5201.0 5257.8 5289.4 5293.3 5334.9 3794.3 3811.4 3812.3 3814.0 3826.3 3854.4 3856.2 3858.7 3858.8 3859.5 4324.5 4349.9 4350.3 4381.5 4385.9 4875.6 5056.9 5062.5 5066.2 5068.3 1321.4 1326.2 1329.2 1329.3 1333.8 867.4 872.6 885.1 896.8 914.4 4469.7 4480.4 4487.3 4496.4 4501.8 5193.8 5198.5 5200.3 5207.4 5210.4 4317.1 4414.7 4467.4 4472.4 4487.3 2747.7 2754.9 2773.2 2774.8 2785.2 4901.4 4928.9 4935.7 4962.6 4975.8 5117.4 5342.5 5346.9 5360.3 5474.0 5026.9 5049.9 5058.6 5062.2 5062.3 5286.1 5308.0 5323.5 5329.1 5335.5 5041.4 5237.2 5242.9 5245.4 5245.9 5005.3 5017.5 5032.0 5036.6 5067.9 3762.4 3795.8 3808.4 3810.6 3812.5 5172.0 5324.0 5336.2 5363.4 5365.7 5121.5 5148.2 5149.2 5149.5 5167.7 5123.9 5127.8 5139.7 5172.2 5178.4 4950.2 5078.2 5084.2 5109.5 5123.5 4929.8 5012.3 5173.5 5178.0 5183.8 5005.9 5014.6 5041.4 5055.2 5084.4 05:57:32 INFO - PROCESS | 11304 | 05:57:32 INFO - PROCESS | 11304 | [#5] yui.html Cycles:180 Average:18802.89 Median:471.08 stddev:28085.46 (5962.0%) stddev-sans-first:28131.07 05:57:32 INFO - PROCESS | 11304 | Values: 621.8 636.6 637.2 701.9 727.0 13528.3 14147.9 14154.7 14155.8 14158.4 12649.4 12989.5 13169.8 13618.6 13653.0 772.6 789.3 793.9 794.0 794.4 615.4 763.5 766.7 769.8 785.8 682.5 686.4 687.9 688.7 698.4 707.2 714.5 716.4 719.3 720.3 471.5 473.0 482.7 484.1 579.2 13548.5 14212.2 14246.5 14250.7 14254.1 11739.9 12651.0 12763.2 12879.9 13053.9 11990.4 12023.5 12134.1 12321.1 12343.9 4134.5 4149.9 4154.1 4172.7 4224.0 69363.7 70035.9 70154.0 70419.0 70768.0 10320.6 10331.7 10413.4 10443.5 10488.8 17894.2 17915.7 17919.6 17924.6 17931.9 6676.4 6746.3 6760.6 6837.6 6900.7 3663.3 3708.1 3746.4 3800.8 3812.3 2736.5 2797.4 2813.9 2832.9 2838.2 486.2 489.6 496.6 497.2 498.1 470.7 479.5 502.4 506.3 538.1 7254.8 7320.2 7335.9 7649.4 7911.8 412.8 470.6 492.1 504.6 528.1 3552.5 3606.6 3742.6 3842.0 3854.3 99628.0 108137.5 108370.0 109164.5 109495.5 95887.0 96371.5 97126.0 97530.5 98078.5 58707.7 78655.6 82742.0 84940.2 85123.8 7162.0 7372.8 7412.3 7413.2 7450.4 46274.9 48072.8 48834.0 49746.0 49980.8 43071.6 67433.0 69568.3 71314.0 71476.6 9106.4 9215.0 9272.0 9327.6 9423.8 10201.6 10205.0 10295.5 11896.2 12298.5 10043.2 10136.9 10170.2 11198.5 12073.3 12513.6 13114.8 13140.1 13151.5 13336.9 10341.6 10386.7 10565.8 10998.3 11082.4 10381.8 10650.7 10887.2 10923.3 11048.0 9768.3 9834.4 9969.2 10296.9 10329.3 05:57:32 INFO - PROCESS | 11304 | -------- Summary: end -------- 05:57:32 INFO - PROCESS | 11304 | 05:57:33 INFO - TEST-INFO | 11304: exit 0 05:57:33 INFO - TEST-OK | dromaeo_css | took 1120061ms 05:57:33 INFO - TEST-START | kraken 05:57:33 INFO - operating with platform_type : linux_ 05:57:33 INFO - Initialising browser for kraken test... 05:57:33 INFO - TEST-INFO | started process 11494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFL7VJx/profile http://localhost:59850/getInfo.html) 05:57:37 INFO - PROCESS | 11494 | __metrics Screen width/height:1600/1200 05:57:37 INFO - PROCESS | 11494 | colorDepth:24 05:57:37 INFO - PROCESS | 11494 | Browser inner width/height: 1024/697 05:57:37 INFO - PROCESS | 11494 | __metrics 05:57:38 INFO - PROCESS | 11494 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:39 INFO - TEST-INFO | 11494: exit 0 05:57:39 INFO - Browser initialized. 05:57:39 INFO - Running cycle 1/1 for kraken test... 05:57:39 INFO - TEST-INFO | started process 11576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFL7VJx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:51 INFO - PROCESS | 11576 | RSS: Main: 158232576 05:57:51 INFO - PROCESS | 11576 | 05:57:54 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:55 INFO - PROCESS | 11576 | RSS: Main: 216506368 05:57:55 INFO - PROCESS | 11576 | 05:57:58 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-dft) 05:57:58 INFO - PROCESS | 11576 | RSS: Main: 204787712 05:57:58 INFO - PROCESS | 11576 | 05:58:01 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-fft) 05:58:02 INFO - PROCESS | 11576 | RSS: Main: 271310848 05:58:02 INFO - PROCESS | 11576 | 05:58:04 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-oscillator) 05:58:05 INFO - PROCESS | 11576 | RSS: Main: 181719040 05:58:05 INFO - PROCESS | 11576 | 05:58:07 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:08 INFO - PROCESS | 11576 | RSS: Main: 185909248 05:58:08 INFO - PROCESS | 11576 | 05:58:11 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:11 INFO - PROCESS | 11576 | RSS: Main: 221720576 05:58:11 INFO - PROCESS | 11576 | 05:58:15 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:15 INFO - PROCESS | 11576 | RSS: Main: 222375936 05:58:15 INFO - PROCESS | 11576 | 05:58:18 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59850/tests/kraken/driver.html?testName=json-parse-financial) 05:58:19 INFO - PROCESS | 11576 | RSS: Main: 222060544 05:58:19 INFO - PROCESS | 11576 | 05:58:21 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:21 INFO - PROCESS | 11576 | RSS: Main: 209526784 05:58:21 INFO - PROCESS | 11576 | 05:58:23 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:24 INFO - PROCESS | 11576 | RSS: Main: 216039424 05:58:24 INFO - PROCESS | 11576 | 05:58:26 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:27 INFO - PROCESS | 11576 | RSS: Main: 211128320 05:58:27 INFO - PROCESS | 11576 | 05:58:29 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:30 INFO - PROCESS | 11576 | RSS: Main: 223064064 05:58:30 INFO - PROCESS | 11576 | 05:58:33 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:33 INFO - PROCESS | 11576 | RSS: Main: 224399360 05:58:33 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59850/tests/kraken/driver.html?testName=ai-astar) 05:58:35 INFO - PROCESS | 11576 | RSS: Main: 267399168 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | __start_tp_report 05:58:35 INFO - PROCESS | 11576 | _x_x_mozilla_page_load 05:58:35 INFO - PROCESS | 11576 | _x_x_mozilla_page_load_details 05:58:35 INFO - PROCESS | 11576 | |i|pagename|runs| 05:58:35 INFO - PROCESS | 11576 | |0;ai-astar;104;111;113;113;113;112;113;112;113;112 05:58:35 INFO - PROCESS | 11576 | |1;audio-beat-detection;145;124;123;174;125;122;150;122;167;122 05:58:35 INFO - PROCESS | 11576 | |2;audio-dft;160;162;162;162;163;161;163;164;162;161 05:58:35 INFO - PROCESS | 11576 | |3;audio-fft;75;76;77;122;75;76;75;76;110;76 05:58:35 INFO - PROCESS | 11576 | |4;audio-oscillator;85;85;116;85;87;85;113;85;85;125 05:58:35 INFO - PROCESS | 11576 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:58:35 INFO - PROCESS | 11576 | |6;imaging-darkroom;147;146;147;147;146;146;146;146;145;147 05:58:35 INFO - PROCESS | 11576 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;95 05:58:35 INFO - PROCESS | 11576 | |8;json-parse-financial;63;62;62;62;63;62;62;62;63;61 05:58:35 INFO - PROCESS | 11576 | |9;json-stringify-tinderbox;64;65;64;65;66;65;65;65;65;66 05:58:35 INFO - PROCESS | 11576 | |10;stanford-crypto-aes;80;79;83;79;79;82;78;80;79;81 05:58:35 INFO - PROCESS | 11576 | |11;stanford-crypto-ccm;129;127;138;131;142;127;133;127;176;128 05:58:35 INFO - PROCESS | 11576 | |12;stanford-crypto-pbkdf2;168;168;167;167;167;163;164;165;162;164 05:58:35 INFO - PROCESS | 11576 | |13;stanford-crypto-sha256-iterative;68;66;67;66;66;69;66;69;69;65 05:58:35 INFO - PROCESS | 11576 | __end_tp_report 05:58:35 INFO - PROCESS | 11576 | __start_cc_report 05:58:35 INFO - PROCESS | 11576 | _x_x_mozilla_cycle_collect,1927 05:58:35 INFO - PROCESS | 11576 | __end_cc_report 05:58:35 INFO - PROCESS | 11576 | __startTimestamp1467982715885__endTimestamp 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | ------- Summary: start ------- 05:58:35 INFO - PROCESS | 11576 | Number of tests: 14 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:2.76 (2.4%) stddev-sans-first:0.73 05:58:35 INFO - PROCESS | 11576 | Values: 104.0 111.0 113.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:135.00 stddev:20.23 (15.0%) stddev-sans-first:21.27 05:58:35 INFO - PROCESS | 11576 | Values: 145.0 124.0 123.0 174.0 125.0 122.0 150.0 122.0 167.0 122.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:0.97 05:58:35 INFO - PROCESS | 11576 | Values: 160.0 162.0 162.0 162.0 163.0 161.0 163.0 164.0 162.0 161.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:17.22 (22.7%) stddev-sans-first:17.96 05:58:35 INFO - PROCESS | 11576 | Values: 75.0 76.0 77.0 122.0 75.0 76.0 75.0 76.0 110.0 76.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.09 (18.9%) stddev-sans-first:16.64 05:58:35 INFO - PROCESS | 11576 | Values: 85.0 85.0 116.0 85.0 87.0 85.0 113.0 85.0 85.0 125.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:58:35 INFO - PROCESS | 11576 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:58:35 INFO - PROCESS | 11576 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 145.0 147.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:58:35 INFO - PROCESS | 11576 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:58:35 INFO - PROCESS | 11576 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 63.0 61.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:58:35 INFO - PROCESS | 11576 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 65.0 65.0 65.0 66.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.56 (2.0%) stddev-sans-first:1.66 05:58:35 INFO - PROCESS | 11576 | Values: 80.0 79.0 83.0 79.0 79.0 82.0 78.0 80.0 79.0 81.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:132.00 stddev:15.02 (11.4%) stddev-sans-first:15.73 05:58:35 INFO - PROCESS | 11576 | Values: 129.0 127.0 138.0 131.0 142.0 127.0 133.0 127.0 176.0 128.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:167.00 stddev:2.17 (1.3%) stddev-sans-first:2.11 05:58:35 INFO - PROCESS | 11576 | Values: 168.0 168.0 167.0 167.0 167.0 163.0 164.0 165.0 162.0 164.0 05:58:35 INFO - PROCESS | 11576 | 05:58:35 INFO - PROCESS | 11576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.52 (2.3%) stddev-sans-first:1.58 05:58:35 INFO - PROCESS | 11576 | Values: 68.0 66.0 67.0 66.0 66.0 69.0 66.0 69.0 69.0 65.0 05:58:35 INFO - PROCESS | 11576 | -------- Summary: end -------- 05:58:35 INFO - PROCESS | 11576 | 05:58:36 INFO - TEST-INFO | 11576: exit 0 05:58:36 INFO - TEST-OK | kraken | took 63553ms 05:58:36 INFO - SUITE-END | took 1183s 05:58:37 INFO - Completed test suite (00:19:43) 05:58:37 INFO - javascript benchmark 05:58:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.842029478231, 2641.339665083729, 2667.30650030992, 2670.853103079331, 2681.3162643525898, 4624.560666736663, 4693.003901689401, 4708.199606066968, 4759.167145749489, 4813.037392521496, 4685.4143232095985, 4738.881527961803, 4743.5256474352545, 4748.667593268473, 4765.547273009067, 4314.050908800059, 4341.196878577458, 4368.759718215497, 4373.322135069069, 4390.385346051556, 4362.1275744851155, 4423.491298500665, 4448.421705178338, 4462.263726485142, 4507.211238033347, 4406.955930440687, 4456.9331460028125, 4458.041521072969, 4464.575865292808, 4494.505604383531, 4297.054647977471, 4319.049809042006, 4359.04101097758, 4369.912601747979, 4391.231534481453, 4324.113556720865, 4353.499347575038, 4354.499232588261, 4361.825526978917, 4422.248217802981, 4767.094252092092, 4786.8085276589245, 4797.136515427222, 4804.087223427572, 4836.056968891067, 4885.487023862479, 4983.750812459362, 5165.535101840815, 5174.586033117379, 5186.611004174664, 5114.053900028507, 5150.201718733602, 5188.11801993662, 5191.065608190562, 5203.635745497817, 4756.21522448799, 4804.711717296974, 4806.086843499724, 4829.154897892855, 4840.128776820206, 5100.413452452941, 5216.426193118754, 5268.236105764643, 5269.736513174403, 5317.361916569959, 5057.72182529957, 5092.388913330424, 5102.36220472441, 5114.514121158559, 5117.078925793393, 5144.6655967362, 5147.948520514822, 5154.8969020620125, 5182.326297581366, 5204.71374074422, 4979.153543897546, 5045.84862454127, 5073.416557095908, 5123.795048198031, 5129.333186685782, 5097.8215762448135, 5098.949010509921, 5112.897742045138, 5117.334746482933, 5121.654139805701, 4287.892802679958, 4289.721168124062, 4289.935650965238, 4319.049809042006, 4340.9131817364105, 3642.1258897864323, 3679.043448703303, 3706.258748250361, 3715.702743780491, 3765.4163604641326, 4418.779061046935, 4420.138073075784, 4434.955650443454, 4467.597916187558, 4476.395686582335, 5092.28707980883, 5118.25785261135, 5135.075686376488, 5142.331496905378, 5194.948050519522, 4282.293421585466, 4336.219480493478, 4376.540463251376, 4383.627391671744, 4431.869873182318, 4549.567791059844, 4556.3165525170825, 4556.863294101182, 4600.838970636011, 4608.216603177468, 4875.0, 4876.268559716071, 4877.414710234794, 4879.756012199305, 4925.064237794808, 4972.8508144755715, 5087.64386492942, 5148.407933087743, 5157.819476318311, 5164.561012313995, 4872.123017856819, 4885.560299572913, 4894.290327902506, 4924.359833221658, 4939.629527785359, 5033.370828646419, 5039.143345631325, 5040.243963405518, 5044.1424957756535, 5057.064443078042, 4921.975390123026, 4992.425871024879, 5074.467180945948, 5094.847154585368, 5154.252633368065, 4972.254161875748, 4974.726390048438, 4985.75071246429, 4990.126727822689, 4998.725070121178, 4950.257461380822, 4966.627502937222, 4967.503249675004, 4967.7516124192925, 5018.899622007466, 4784.210605250234, 4839.975800120977, 4890.975545122252, 4900.215965445512, 4959.132151873336, 5022.698638081727, 5063.291139240436, 5112.667676601009, 5116.897662046813, 5118.283440318432, 4921.188003979303, 4926.704397736147, 4932.2601609757385, 4935.901281974268, 4983.25251212321], "value": 4693.518054342099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.6058716549752, 534.9304590403249, 540.697209562645, 583.6964778315277, 590.1413443439795, 26748.191439898797, 38231.23537529251, 39663.20673586534, 39671.40492892605, 43394.78302608483, 39281.803590982, 39612.60387396132, 39736.0, 39796.20407591854, 39803.800980995125, 7271.236520165386, 7567.016287882581, 7698.692052317901, 7755.418343624223, 7758.185390533998, 9755.95122024389, 10068.647597334095, 10069.496525173749, 10360.740981475486, 10372.066514013737, 10108.898911010869, 10201.43892085935, 10214.080732734052, 10217.591296348175, 10230.948845255763, 7340.082489688789, 9835.901640983642, 10041.598336066549, 10086.596536138546, 10116.089551940287, 9972.750681232954, 10030.0, 10035.648752293635, 10035.899641003643, 10050.296479246455, 38187.618123818684, 38394.0, 38424.0, 38518.42222366667, 38585.228295434215, 2940.2061443410375, 2992.58103865459, 3001.639803223605, 3043.04144194578, 3076.2463196516774, 28174.295642608893, 28370.148895533166, 28375.290617734514, 28415.821430521893, 29137.85431072831, 3535.5403797506415, 3576.695980841632, 3596.334678084537, 3627.075095850568, 3670.46778217157, 251191.0, 253608.0, 253638.0, 253828.0, 253844.73077634678, 51149.23276150861, 51254.23118653223, 51346.74326628343, 51750.0, 51804.740976294874, 32425.351492970007, 33208.83395583055, 33639.0, 35409.291814163575, 52820.0, 13917.86082139186, 14127.64680882986, 14133.929330353283, 14159.362828672734, 14161.645958850904, 9363.859542106873, 9633.951830240803, 10260.127889129508, 10564.841527377095, 10689.091427228772, 17912.820871791377, 17935.461936141935, 17978.640427191644, 18018.819811801975, 18098.819011809977, 6747.662616869137, 6764.898526522106, 6964.965175174092, 7010.474214433836, 7026.15686117659, 802.6548584108889, 886.6054605700531, 907.1925985872579, 933.9206167475704, 948.4404201521136, 27773.166804995883, 28317.57523637147, 28332.858335708188, 28546.143615691562, 28554.85722571374, 920.7882187096872, 930.2929773372285, 945.0030218119949, 951.6288647427509, 996.3225006995168, 13773.311334433238, 14246.643833904236, 14513.927430362992, 14644.633884152769, 14654.63363415923, 396902.0, 401691.0, 401903.0, 402080.0, 403078.0, 46750.766246168554, 46921.76539117283, 47209.29186062212, 47223.76388118038, 47383.05233895372, 1041.8385150301565, 1106.446776611694, 1149.5286932357694, 1171.7773623011772, 1195.935617300603, 27933.441331173668, 27988.02041928523, 29407.705922940495, 30053.54919676163, 30212.395752085275, 43366.783166083966, 43953.56046439495, 44042.779786100866, 44108.0, 44214.336784947605, 358316.0, 365243.0, 365438.0, 365534.0, 366962.0, 31149.844250778602, 39093.2181356377, 39494.80252598719, 39682.40476392914, 42051.7897410511, 39305.213895722496, 42894.57105428906, 42924.0, 43561.56438435702, 43806.12387752291, 36396.27207455783, 36962.8151859239, 37163.81418092892, 37422.25155496929, 37906.346555740834, 37060.62939370572, 37211.25577488489, 37487.0, 37623.24753504969, 41226.0, 31302.0, 31350.216244593154, 32067.518987215677, 32113.357732844746, 32147.196320092185, 33156.33687326288, 33869.491957620165, 34347.14132146716, 34377.484337735455, 34774.82612586921, 25733.3566660835, 26115.477690445703, 26224.0, 26230.0, 26756.0], "value": 17964.3619295955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.3575514360157, 374.87816459650605, 378.1472778883617, 384.5385537355171, 385.5643123270705, 16550.751738723913, 17677.82322176778, 17766.91116544417, 18634.81365186348, 18654.253829846806, 14690.192039437827, 14732.410703571844, 14992.400303987828, 15027.549173524785, 15034.849651503482, 5056.620753443497, 5221.895562088756, 5260.737423018486, 5263.34208223972, 5263.684178949256, 3764.755290906096, 3947.2697550953167, 5074.923876141861, 5692.601517893749, 5993.670348130851, 5965.284165900076, 5985.431384018533, 5989.760409583611, 5991.970040149793, 5993.730282137314, 5795.913061304083, 6103.29812071613, 6103.877922441548, 6113.969430152865, 6119.143319935212, 3386.86452541898, 5070.112730272188, 5343.118385466393, 5352.705601191933, 5377.75800088993, 18001.279948802032, 18034.36879709217, 18994.810051899443, 22598.0, 22604.095836166533, 2338.5089131282452, 2572.4212052288085, 2573.704024037222, 2576.0854896511655, 2576.6263891735593, 13848.446062157502, 13875.167489950636, 13885.861141388557, 13956.441742330295, 14004.369803358772, 1779.5729025034027, 1834.4955137337206, 1848.3068849181557, 1856.0348618718326, 1913.9043047847551, 67436.0, 68669.3133068668, 69315.3068469319, 69812.30187698109, 71388.64305678438, 9640.75898102553, 9661.275404344702, 10185.0, 10199.745006374751, 10290.536925838205, 13738.381772820247, 13848.515301964382, 13848.930755346159, 13865.0, 13888.722225555432, 6937.340952609494, 7079.115110611174, 7091.6454177290925, 7122.679479423438, 7133.500654954103, 6489.70796314167, 6514.3811337922825, 6527.771527996498, 6617.7683781067435, 6632.900506492407, 6324.873502529924, 6324.968375158095, 6358.586691865014, 6367.586106903036, 6384.936150638527, 1533.5935976966114, 1585.5243426971863, 1743.2068408873931, 1773.3438627707574, 1783.8572914166834, 771.5370777533435, 812.5937031484258, 826.2357319479457, 830.8961379827522, 905.9637614495479, 15834.28745706446, 15945.760813587805, 16403.5899102521, 16443.0, 16635.584110397336, 839.8572242718752, 847.3009766942297, 851.923326900582, 906.5829718329642, 912.5346073502561, 9500.48237217138, 9883.604655813831, 10045.19638428924, 10103.797924041624, 10167.593296268215, 364052.5163238548, 366030.0, 367974.0, 375009.0, 379747.70883019513, 68170.65914670494, 68865.3113468869, 70192.0, 70672.64663676648, 71393.0, 879.4942907827897, 880.5377176982007, 908.246155690775, 909.9636014559476, 910.8952470465849, 14992.0, 15112.697746045238, 15124.470643527864, 15269.236538172825, 15533.378664853732, 34694.82652586721, 35249.64750352566, 35430.64569354377, 35539.0, 35868.0, 48942.953941033345, 56541.71729141328, 57369.0, 57779.4222057774, 58115.70942145431, 7344.934984427335, 8021.63902624395, 8047.396445266511, 10832.837507437553, 11335.0, 12189.634310970685, 12329.691757706129, 12500.687482812638, 12683.175593586388, 12850.871491284968, 11404.714882128013, 11423.200375973602, 11479.540818367172, 11534.653960381202, 11577.6526704199, 11365.204435689422, 11506.94246528762, 11587.073034157078, 11851.525938962344, 12045.0, 11349.546018159512, 11512.942435288105, 11678.0, 11829.231099978473, 11842.348670823187, 11770.94114529456, 12000.0, 12024.699382515508, 12073.154879158375, 12083.39583020863, 11178.496967636313, 11294.322340659586, 11336.14978876604, 11494.54021839117, 11518.712032199262], "value": 8659.229555578537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.194071616314, 1367.7811550151976, 1422.2391020803873, 1673.4814104772315, 1693.212656114907, 7451.403887688985, 7896.842063158733, 7956.0, 7958.323542498894, 7962.522248665077, 6665.43343815775, 7120.359167674908, 7319.414446844253, 7319.9268007319915, 7764.223577642247, 2165.231342873277, 2180.738311402634, 2183.4323076000273, 2192.419008962618, 2193.144673577306, 1862.0782712557302, 2096.4549217203485, 2103.57928414317, 2110.2297661353573, 2113.968290475644, 2133.1467413034834, 2219.4562332228625, 2225.666150077493, 2239.8992045358, 2240.6526988316755, 2204.0522575292616, 2204.1183526589334, 2206.801387875083, 2216.445888527868, 2227.5544891021777, 2059.783722709109, 2065.834733221354, 2066.214838361428, 2067.1937944201773, 2090.8850013249266, 7781.922180778233, 7903.288704016666, 7909.7231596893835, 7914.3272821810215, 7918.0, 4378.343248512717, 4455.376247325345, 4485.618722408599, 4486.685931984763, 4490.685652004361, 2724.5368287391193, 2804.0, 2849.33040735427, 2849.4443583501225, 2855.4003659231585, 894.3292530602048, 895.6283142495856, 900.8108297257584, 917.6650522559285, 940.8917974432959, 10376.79246415075, 10456.895431045668, 10463.372197668165, 10488.108510776518, 10496.842547361872, 4052.6352628263007, 4190.832366705297, 4327.870163895088, 4334.8266069357505, 4350.891227719269, 9000.549972501349, 9044.592993315317, 9051.230645395215, 9062.864057039149, 9062.954685226532, 4692.225782745809, 4692.7653617319, 4699.036697477009, 4703.106409782131, 4705.694129881546, 4173.624373806372, 4177.436046133733, 4280.400743895857, 4289.571042895748, 4294.527601963781, 3649.233660931181, 3704.981475092661, 3715.64701353371, 3753.9061523461587, 3761.2665530221893, 1072.158355690779, 1157.7973854575584, 1174.4127936031985, 1183.4674396521427, 1196.0790191552455, 679.9320067993161, 771.5872008475438, 805.9032916049995, 817.1215942861447, 837.1753822484848, 5074.619403544675, 5186.533212010937, 5272.2882410874045, 5290.867728306746, 5354.9464505354445, 826.3059030414361, 853.3130829682166, 863.8747381629629, 904.0597778310615, 908.2234689340651, 3429.5198672185916, 3632.8365223565, 3653.5433070866143, 3658.4512323151207, 3727.459518369821, 8908.643654253758, 9112.043235460182, 9151.17639412456, 9155.13026262504, 9166.175044245916, 8284.461510001951, 8859.11408859122, 9039.23166530839, 9070.047644997312, 9313.20837728787, 7113.466490013167, 7300.0, 7306.890396643948, 7317.085364329459, 7319.194888562254, 5356.7589458473685, 5357.276767636319, 5390.676559406291, 5495.780168793363, 5536.031194541019, 8777.078406767198, 8994.910050899669, 9009.144131307516, 9015.188633022797, 9015.549222538715, 8845.159709827556, 8984.011758706407, 8994.235489983424, 9113.36206465541, 9255.167034966616, 6822.181338239443, 6864.622445765531, 6886.24251332363, 6886.414654754201, 6897.137857767779, 7048.189458212166, 7225.24134965821, 7235.674394652358, 7242.493025488166, 7243.674034668347, 5156.4327923927585, 6627.4698024158915, 6656.667166641551, 6682.365175308338, 6939.826504337432, 6302.243730752339, 6654.83362915931, 6690.899636505554, 6763.12079429671, 6840.965795170992, 6206.565540412128, 6255.874882502233, 6278.058291256348, 6281.277653069773, 6284.245890492987, 4411.9558804411545, 4475.194464996332, 4488.775561221861, 4605.976970115128, 4608.3778689876435, 4535.614472769851, 4569.246074397687, 4577.130345234395, 4632.189366860718, 4700.365450664253], "value": 4095.7883713821166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6024937456619, 309.5913394319499, 314.87090292979883, 316.16847690573786, 316.7291965369607, 4882.365292511973, 4889.8533044008645, 4909.950900490994, 4911.410630724309, 4914.2137258038765, 4860.8541743747655, 4863.246196839486, 4869.784248167084, 4878.317035615008, 4889.559939605435, 3653.5433070866143, 3730.7874940644265, 3785.829637666298, 3867.0719027433356, 3902.180542086165, 3839.1745774658443, 3842.3083844907906, 3880.068783491956, 3926.509186351706, 3928.8428462861452, 3801.752886062397, 3837.328467518187, 3845.42318652203, 3856.055266459721, 3860.4402361657544, 3601.94597081044, 3648.3797754381685, 3775.716821238391, 3780.4878048780433, 3787.822002348633, 3333.683300086488, 3333.783304085251, 3341.4319565673895, 3341.448660970937, 3345.933081338384, 4777.832775852863, 4798.880027999293, 4801.8079276828885, 4803.351547541072, 4807.423109226916, 4236.964994032802, 4343.522212556616, 4343.956560434387, 4369.388285640013, 4405.757683327416, 5022.949770502285, 5047.268146118792, 5050.671706339076, 5057.216131499624, 5080.974595127001, 3699.038250054978, 3700.204456041937, 3703.4815125882396, 3722.553293604785, 3730.2166545025575, 5201.0, 5257.79172747447, 5289.365276166846, 5293.285406470154, 5334.946650533484, 3794.317022935843, 3811.4092315691114, 3812.3328417526823, 3813.9809300953316, 3826.2730081284467, 3854.421836724514, 3856.2480316338047, 3858.6913046956174, 3858.7684738915755, 3859.5368555772925, 4324.481062272547, 4349.869503914824, 4350.282203436397, 4381.539938306496, 4385.890352741143, 4875.585575226146, 5056.924146137811, 5062.4684408137355, 5066.16408292635, 5068.290439338495, 1321.4251800466636, 1326.2109045118139, 1329.1692692067459, 1329.288830475691, 1333.7999300105062, 867.3754896474528, 872.5506364222431, 885.1369914333602, 896.8430524658158, 914.3553794574809, 4469.664775141878, 4480.417545719036, 4487.259602165606, 4496.4154659894, 4501.842435514741, 5193.766280517386, 5198.454162312978, 5200.349956255468, 5207.3751149862255, 5210.400803907523, 4317.114991426813, 4414.713043652152, 4467.419235499429, 4472.39622650938, 4487.326900964881, 2747.6565429321336, 2754.931126721848, 2773.1541879726474, 2774.8473833938924, 2785.206216228365, 4901.36282283308, 4928.852134435972, 4935.716713654404, 4962.60299176065, 4975.776090075955, 5117.360329958755, 5342.54588359986, 5346.946530534723, 5360.311501876897, 5474.0, 5026.874328141826, 5049.924251136236, 5058.58359659296, 5062.240663900445, 5062.265971434122, 5286.101362768261, 5307.974454561017, 5323.494268044529, 5329.120695085423, 5335.493128152819, 5041.369828771403, 5237.214417837355, 5242.921356179737, 5245.423003469692, 5245.868853278546, 5005.299258103795, 5017.523335283142, 5032.043911656773, 5036.575128912375, 5067.949320506747, 3762.435634654824, 3795.8291876865055, 3808.4477750725437, 3810.6379893910034, 3812.5234345706785, 5171.991461664939, 5323.987398964534, 5336.226247194213, 5363.436839131991, 5365.704886231295, 5121.487851214849, 5148.2020286855595, 5149.150390185578, 5149.459306772735, 5167.689938603696, 5123.87190320245, 5127.79488820443, 5139.691618502902, 5172.224166375074, 5178.394697643743, 4950.2079667253065, 5078.206986157525, 5084.211947148198, 5109.46350633193, 5123.513266239701, 4929.767558110472, 5012.273220383097, 5173.534381905646, 5177.974110129425, 5183.8487027883, 5005.947561499767, 5014.57376123019, 5041.428871275749, 5055.216441451581, 5084.440711521655], "value": 3875.533214513804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.8383220362707, 636.6466611030877, 637.2194062273712, 701.8666453373856, 727.0330460487552, 13528.323583820806, 14147.858521414782, 14154.71690566188, 14155.787663185034, 14158.362873670683, 12649.430775615096, 12989.48042078318, 13169.802452963213, 13618.591442256724, 13653.0, 772.6329993253202, 789.3211837819499, 793.9444238903279, 793.9682412703485, 794.3883209928351, 615.3723202333639, 763.5037225803245, 766.7239793674273, 769.7690692792168, 785.7956931197901, 682.5051837417857, 686.4268335939496, 687.9415249703782, 688.6556721639181, 698.354022529161, 707.1937990690617, 714.5105602662142, 716.4268585131925, 719.3094629156017, 720.2653293640484, 471.4578235029709, 473.00668595948576, 482.6959015820011, 484.06816877511005, 579.1775678536488, 13548.45806167752, 14212.218327991955, 14246.501372452018, 14250.714985700331, 14254.14475131485, 11739.941300293529, 12651.0, 12763.234205947672, 12879.87120128796, 13053.934730326382, 11990.400479975966, 12023.458944347438, 12134.089943254203, 12321.075919306088, 12343.93828030863, 4134.462519872427, 4149.875503734893, 4154.1068670235745, 4172.687048471377, 4224.0, 69363.65318173377, 70035.94946075813, 70154.0, 70419.0, 70768.0, 10320.587176512856, 10331.652299207542, 10413.42726150069, 10443.530041148166, 10488.842667359995, 17894.194761235776, 17915.73126403105, 17919.641607167785, 17924.641507170043, 17931.910340448216, 6676.399124078856, 6746.325367463312, 6760.594364338155, 6837.555558888656, 6900.723971041102, 3663.3405986922608, 3708.128589781399, 3746.4193050077283, 3800.809959502014, 3812.275667623143, 2736.50742866282, 2797.398559309758, 2813.887444502238, 2832.929176770597, 2838.233676907265, 486.2390359088016, 489.6058672768456, 496.5704665464347, 497.16972655665126, 498.12081675842165, 470.6940488682384, 479.4510285722898, 502.38708775294083, 506.29624821498146, 538.1148011521026, 7254.782356529313, 7320.15818180916, 7335.926640733631, 7649.426293027934, 7911.76264712048, 412.8080442594208, 470.5858844217067, 492.0847224163054, 504.6316189181844, 528.0916823064323, 3552.5381700378784, 3606.6290437962152, 3742.5883152853166, 3842.028862605847, 3854.2676891390547, 99628.04463464285, 108137.45931270294, 108370.0, 109164.4541777286, 109495.45252273687, 95887.0, 96371.51814240884, 97126.0, 97530.51234743923, 98078.5096074515, 58707.70646146742, 78655.60672196717, 82742.0, 84940.15059849447, 85123.76448001865, 7162.0, 7372.815679607838, 7412.295831895961, 7413.221611730906, 7450.36671882896, 46274.87642595, 48072.7596362016, 48834.0, 49746.00507989748, 49980.75240594926, 43071.56928430676, 67433.0, 69568.30431695821, 71314.0, 71476.64261678659, 9106.362554621113, 9215.0, 9271.953640232026, 9327.580258888502, 9423.764405889908, 10201.591936322464, 10205.0, 10295.53670084863, 11896.167268291136, 12298.508059677513, 10043.246756493147, 10136.949315253376, 10170.237232207466, 11198.496067677137, 12073.335966521925, 12513.562025329435, 13114.803277950648, 13140.145890517086, 13151.53969611059, 13336.866631333562, 10341.586336546454, 10386.740331491774, 10565.788684226427, 10998.285111467729, 11082.390468524309, 10381.84427233577, 10650.73373165677, 10887.18346124028, 10923.289986150874, 11048.0, 9768.316217864682, 9834.360766550151, 9969.152622027208, 10296.897031029594, 10329.328593641389], "value": 6466.740657756126, "unit": "score"}], "name": "dromaeo_css", "value": 6493.304847662413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 174.0, 125.0, 122.0, 150.0, 122.0, 167.0, 122.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0, 164.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 122.0, 75.0, 76.0, 75.0, 76.0, 110.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 87.0, 85.0, 113.0, 85.0, 85.0, 125.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 83.0, 79.0, 79.0, 82.0, 78.0, 80.0, 79.0, 81.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 138.0, 131.0, 142.0, 127.0, 133.0, 127.0, 176.0, 128.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 167.0, 167.0, 167.0, 163.0, 164.0, 165.0, 162.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 66.0, 66.0, 69.0, 66.0, 69.0, 69.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1524.0, "alertThreshold": 2.0}]} 05:58:37 INFO - Return code: 0 05:58:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:37 INFO - # TBPL SUCCESS # 05:58:37 INFO - Running post-action listener: _resource_record_post_action 05:58:37 INFO - ##### 05:58:37 INFO - ##### Finished run-tests step (success) 05:58:37 INFO - ##### 05:58:37 INFO - Running post-run listener: _resource_record_post_run 05:58:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555757568; Read time: 16; Write time: 530312 05:58:37 INFO - TinderboxPrint: CPU usage
13.0% 05:58:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:58:37 INFO - TinderboxPrint: I/O write bytes / time
555,757,568 / 530,312 05:58:37 INFO - TinderboxPrint: CPU idle
8,335.9 (87.0%) 05:58:37 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 05:58:37 INFO - TinderboxPrint: Swap in / out
0 / 0 05:58:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266833920; Read time: 0; Write time: 275384 05:58:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288423936; Read time: 0; Write time: 254856 05:58:37 INFO - Running post-run listener: _upload_blobber_files 05:58:37 INFO - Blob upload gear active. 05:58:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:37 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 05:58:37 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'] 05:58:37 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 05:58:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:39 INFO - (blobuploader) - INFO - Done attempting. 05:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:39 INFO - (blobuploader) - INFO - Done attempting. 05:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:43 INFO - (blobuploader) - INFO - Done attempting. 05:58:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:43 INFO - Return code: 0 05:58:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df4e31ca82dc1bdbb5ac88571aace4ff2bf4519dd58d48fb421de6bf87433f0b6342e376413a7c35d9e9f9fc36f2cde988f2ca159d0a224771b51dac20252ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ed8f05119cfa933eaff62f4194478af812044626a02bb372959f4459930846f3f21a8223eee0fa5d2e6cda777c301bfa56f002d6ee6d86c492e08aec8713c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/178b35e8f2d476ff3ea90f677e6de060e24d8d16d787f99a8596b397a30572503e9a8f259d7fa7193dfd81df54ee3ff10f4800fc8c20cccbc7302dc13f0b4516"} 05:58:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:43 INFO - Contents: 05:58:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df4e31ca82dc1bdbb5ac88571aace4ff2bf4519dd58d48fb421de6bf87433f0b6342e376413a7c35d9e9f9fc36f2cde988f2ca159d0a224771b51dac20252ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ed8f05119cfa933eaff62f4194478af812044626a02bb372959f4459930846f3f21a8223eee0fa5d2e6cda777c301bfa56f002d6ee6d86c492e08aec8713c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/178b35e8f2d476ff3ea90f677e6de060e24d8d16d787f99a8596b397a30572503e9a8f259d7fa7193dfd81df54ee3ff10f4800fc8c20cccbc7302dc13f0b4516"} 05:58:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:43 INFO - Copying logs to upload dir... 05:58:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.444844 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 05:58:43.219074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:58:43.223206) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 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/1df4e31ca82dc1bdbb5ac88571aace4ff2bf4519dd58d48fb421de6bf87433f0b6342e376413a7c35d9e9f9fc36f2cde988f2ca159d0a224771b51dac20252ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ed8f05119cfa933eaff62f4194478af812044626a02bb372959f4459930846f3f21a8223eee0fa5d2e6cda777c301bfa56f002d6ee6d86c492e08aec8713c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/178b35e8f2d476ff3ea90f677e6de060e24d8d16d787f99a8596b397a30572503e9a8f259d7fa7193dfd81df54ee3ff10f4800fc8c20cccbc7302dc13f0b4516"} build_url:https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/GiIMtWKcQwmaZ3LI7Oo5DQ/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/1df4e31ca82dc1bdbb5ac88571aace4ff2bf4519dd58d48fb421de6bf87433f0b6342e376413a7c35d9e9f9fc36f2cde988f2ca159d0a224771b51dac20252ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ed8f05119cfa933eaff62f4194478af812044626a02bb372959f4459930846f3f21a8223eee0fa5d2e6cda777c301bfa56f002d6ee6d86c492e08aec8713c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/178b35e8f2d476ff3ea90f677e6de060e24d8d16d787f99a8596b397a30572503e9a8f259d7fa7193dfd81df54ee3ff10f4800fc8c20cccbc7302dc13f0b4516"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:58:43.254728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:58:43.255253) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467981482.138455-1704736796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004731 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:58:43.340357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:58:43.340854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:58:43.341331) ========= ========= Total master_lag: 0.20 =========