builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1468653776.72 results: success (0) buildid: 20160715230551 builduid: 59035499692b414eb7967ee1436532f7 revision: c47d2ca42dff8772f2e86be895ff331346a37b6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.724129) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.724621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.724939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.739937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.740360) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 00:22:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.8M=0s 2016-07-16 00:22:57 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.880743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.881101) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.930456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:56.930819) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c47d2ca42dff8772f2e86be895ff331346a37b6c --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 c47d2ca42dff8772f2e86be895ff331346a37b6c --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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 00:22:57,251 truncating revision to first 12 chars 2016-07-16 00:22:57,251 Setting DEBUG logging. 2016-07-16 00:22:57,252 attempt 1/10 2016-07-16 00:22:57,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c47d2ca42dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 00:22:57,565 unpacking tar archive at: fx-team-c47d2ca42dff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:57.666243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:57.666577) ========= script_repo_revision: c47d2ca42dff8772f2e86be895ff331346a37b6c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:57.666967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:57.667247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 00:22:57.678260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-16 00:22:57.678743) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:22:58 INFO - MultiFileLogger online at 20160716 00:22:58 in /builds/slave/test 00:22:58 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 00:22:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:22:58 INFO - {'append_to_log': False, 00:22:58 INFO - 'base_work_dir': '/builds/slave/test', 00:22:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:22:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:22:58 INFO - 'branch': 'Fx-Team-Non-PGO', 00:22:58 INFO - 'buildbot_json_path': 'buildprops.json', 00:22:58 INFO - 'config_files': ('talos/linux_config.py',), 00:22:58 INFO - 'default_actions': ('clobber', 00:22:58 INFO - 'read-buildbot-config', 00:22:58 INFO - 'download-and-extract', 00:22:58 INFO - 'populate-webroot', 00:22:58 INFO - 'create-virtualenv', 00:22:58 INFO - 'install', 00:22:58 INFO - 'run-tests'), 00:22:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:22:58 INFO - 'download_minidump_stackwalk': True, 00:22:58 INFO - 'download_symbols': 'ondemand', 00:22:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:22:58 INFO - 'tooltool.py': '/tools/tooltool.py', 00:22:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:22:58 INFO - '/tools/misc-python/virtualenv.py')}, 00:22:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:22:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:22:58 INFO - 'installer_path': 'installer.exe', 00:22:58 INFO - 'log_level': 'info', 00:22:58 INFO - 'log_name': 'talos', 00:22:58 INFO - 'log_to_console': True, 00:22:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:22:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:22:58 INFO - 'opt_config_files': (), 00:22:58 INFO - 'pip_index': False, 00:22:58 INFO - 'sps_profile': False, 00:22:58 INFO - 'sps_profile_interval': 0, 00:22:58 INFO - 'suite': 'dromaeojs', 00:22:58 INFO - 'system_bits': '32', 00:22:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:22:58 INFO - 'title': 'talos-linux64-ix-057', 00:22:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:22:58 INFO - 'use_talos_json': True, 00:22:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:22:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:22:58 INFO - 'work_dir': 'build'} 00:22:58 INFO - ##### 00:22:58 INFO - ##### Running clobber step. 00:22:58 INFO - ##### 00:22:58 INFO - Running pre-action listener: _resource_record_pre_action 00:22:58 INFO - Running main action method: clobber 00:22:58 INFO - rmtree: /builds/slave/test/build 00:22:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:22:58 INFO - Running post-action listener: _resource_record_post_action 00:22:58 INFO - ##### 00:22:58 INFO - ##### Finished clobber step (success) 00:22:58 INFO - ##### 00:22:58 INFO - ##### 00:22:58 INFO - ##### Running read-buildbot-config step. 00:22:58 INFO - ##### 00:22:58 INFO - Running pre-action listener: _resource_record_pre_action 00:22:58 INFO - Running main action method: read_buildbot_config 00:22:58 INFO - Using buildbot properties: 00:22:58 INFO - { 00:22:58 INFO - "project": "", 00:22:58 INFO - "product": "firefox", 00:22:58 INFO - "script_repo_revision": "production", 00:22:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:22:58 INFO - "repository": "", 00:22:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:22:58 INFO - "buildid": "20160715230551", 00:22:58 INFO - "pgo_build": "False", 00:22:58 INFO - "basedir": "/builds/slave/test", 00:22:58 INFO - "buildnumber": 3164, 00:22:58 INFO - "slavename": "talos-linux64-ix-057", 00:22:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:22:58 INFO - "platform": "ubuntu64_hw", 00:22:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:22:58 INFO - "branch": "fx-team", 00:22:58 INFO - "repo_path": "integration/fx-team", 00:22:58 INFO - "revision": "c47d2ca42dff8772f2e86be895ff331346a37b6c", 00:22:58 INFO - "stage_platform": "linux64", 00:22:58 INFO - "builduid": "59035499692b414eb7967ee1436532f7", 00:22:58 INFO - "slavebuilddir": "test" 00:22:58 INFO - } 00:22:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:22:58 INFO - Running post-action listener: _resource_record_post_action 00:22:58 INFO - ##### 00:22:58 INFO - ##### Finished read-buildbot-config step (success) 00:22:58 INFO - ##### 00:22:58 INFO - ##### 00:22:58 INFO - ##### Running download-and-extract step. 00:22:58 INFO - ##### 00:22:58 INFO - Running pre-action listener: _resource_record_pre_action 00:22:58 INFO - Running main action method: download_and_extract 00:22:58 INFO - mkdir: /builds/slave/test/build/tests 00:22:58 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')]} 00:22:58 INFO - https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:22:59 INFO - Downloaded 1361 bytes. 00:22:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:22:59 INFO - Using the following test package requirements: 00:22:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:22:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:22:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:22:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'jsshell-linux-x86_64.zip'], 00:22:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:22:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:22:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:22:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:22:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:22:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:22:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:59 INFO - https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:00 INFO - Downloaded 22757638 bytes. 00:23:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:23:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:23:01 INFO - Return code: 0 00:23:01 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 00:23:01 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')]} 00:23:01 INFO - https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:20 INFO - Downloaded 22757638 bytes. 00:23:20 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'] 00:23:20 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 00:23:21 INFO - Return code: 0 00:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:21 INFO - https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:23 INFO - Downloaded 14403317 bytes. 00:23:23 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'] 00:23:23 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 00:23:23 INFO - Return code: 0 00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:23 INFO - https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yyu785fjSi6bplgT7O2a-Q/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 00:23:25 INFO - Downloaded 57079581 bytes. 00:23:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:23:25 INFO - mkdir: /builds/slave/test/properties 00:23:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:23:25 INFO - Writing to file /builds/slave/test/properties/build_url 00:23:25 INFO - Contents: 00:23:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:23:26 INFO - Running post-action listener: _resource_record_post_action 00:23:26 INFO - Running post-action listener: set_extra_try_arguments 00:23:26 INFO - ##### 00:23:26 INFO - ##### Finished download-and-extract step (success) 00:23:26 INFO - ##### 00:23:26 INFO - ##### 00:23:26 INFO - ##### Running populate-webroot step. 00:23:26 INFO - ##### 00:23:26 INFO - Running pre-action listener: _resource_record_pre_action 00:23:26 INFO - Running main action method: populate_webroot 00:23:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:23:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:23:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:23:26 INFO - '--tppagecycles', 00:23:26 INFO - '7'], 00:23:26 INFO - 'tests': ['tsvgm']}}, 00:23:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:23:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:23:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:23:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:23:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['damp', 'tps']}, 00:23:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'tests': ['damp', 'tps']}, 00:23:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['dromaeo_dom']}, 00:23:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:23:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['basic_compositor_video']}, 00:23:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:23:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'other-e10s': {'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['a11yr', 00:23:26 INFO - 'ts_paint', 00:23:26 INFO - 'tpaint', 00:23:26 INFO - 'sessionrestore', 00:23:26 INFO - 'sessionrestore_no_auto_restore', 00:23:26 INFO - 'tabpaint']}, 00:23:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['tsvgx', 00:23:26 INFO - 'tsvgr_opacity', 00:23:26 INFO - 'tart', 00:23:26 INFO - 'tscrollx', 00:23:26 INFO - 'cart']}, 00:23:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:23:26 INFO - 'tsvgr_opacity', 00:23:26 INFO - 'tart', 00:23:26 INFO - 'tscrollx', 00:23:26 INFO - 'cart']}, 00:23:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'talos_options': ['--disable-e10s'], 00:23:26 INFO - 'tests': ['tp5o']}, 00:23:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'tests': ['tp5o']}, 00:23:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'talos_options': ['--disable-e10s', 00:23:26 INFO - '--xperf_path', 00:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:26 INFO - 'tests': ['tp5n']}, 00:23:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:26 INFO - 'talos_options': ['--xperf_path', 00:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:26 INFO - 'tests': ['tp5n']}}, 00:23:26 INFO - 'talos.zip': {'path': '', 00:23:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:23:26 INFO - Running post-action listener: _resource_record_post_action 00:23:26 INFO - ##### 00:23:26 INFO - ##### Finished populate-webroot step (success) 00:23:26 INFO - ##### 00:23:26 INFO - ##### 00:23:26 INFO - ##### Running create-virtualenv step. 00:23:26 INFO - ##### 00:23:26 INFO - Running pre-action listener: _resource_record_pre_action 00:23:26 INFO - Running main action method: create_virtualenv 00:23:26 INFO - Creating virtualenv /builds/slave/test/build/venv 00:23:26 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 00:23:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:23:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:23:26 INFO - Using real prefix '/usr' 00:23:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:23:26 INFO - Installing distribute.............................................................................................................................................................................................done. 00:23:28 INFO - Installing pip.................done. 00:23:28 INFO - Return code: 0 00:23:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:23:28 INFO - Using env: {'DISPLAY': ':0', 00:23:28 INFO - 'HOME': '/home/cltbld', 00:23:28 INFO - 'LANG': 'en_US.UTF-8', 00:23:28 INFO - 'LANGUAGE': 'en_US:en', 00:23:28 INFO - 'LOGNAME': 'cltbld', 00:23:28 INFO - 'MAIL': '/var/mail/cltbld', 00:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:28 INFO - 'MOZ_NO_REMOTE': '1', 00:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:28 INFO - 'NO_EM_RESTART': '1', 00:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:28 INFO - 'PWD': '/builds/slave/test', 00:23:28 INFO - 'SHELL': '/bin/bash', 00:23:28 INFO - 'SHLVL': '1', 00:23:28 INFO - 'TERM': 'linux', 00:23:28 INFO - 'TMOUT': '86400', 00:23:28 INFO - 'USER': 'cltbld', 00:23:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:28 INFO - '_': '/tools/buildbot/bin/python'} 00:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:28 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 00:23:28 INFO - Cleaning up... 00:23:28 INFO - Return code: 0 00:23:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:23:28 INFO - Using env: {'DISPLAY': ':0', 00:23:28 INFO - 'HOME': '/home/cltbld', 00:23:28 INFO - 'LANG': 'en_US.UTF-8', 00:23:28 INFO - 'LANGUAGE': 'en_US:en', 00:23:28 INFO - 'LOGNAME': 'cltbld', 00:23:28 INFO - 'MAIL': '/var/mail/cltbld', 00:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:28 INFO - 'MOZ_NO_REMOTE': '1', 00:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:28 INFO - 'NO_EM_RESTART': '1', 00:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:28 INFO - 'PWD': '/builds/slave/test', 00:23:28 INFO - 'SHELL': '/bin/bash', 00:23:28 INFO - 'SHLVL': '1', 00:23:28 INFO - 'TERM': 'linux', 00:23:28 INFO - 'TMOUT': '86400', 00:23:28 INFO - 'USER': 'cltbld', 00:23:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:28 INFO - '_': '/tools/buildbot/bin/python'} 00:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:29 INFO - Downloading/unpacking psutil>=3.1.1 00:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:31 INFO - Installing collected packages: psutil 00:23:31 INFO - Running setup.py install for psutil 00:23:31 INFO - building 'psutil._psutil_linux' extension 00:23:31 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 00:23:31 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 00:23:31 INFO - building 'psutil._psutil_posix' extension 00:23:31 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 00:23:31 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 00:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:31 INFO - Successfully installed psutil 00:23:31 INFO - Cleaning up... 00:23:31 INFO - Return code: 0 00:23:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:23:31 INFO - Using env: {'DISPLAY': ':0', 00:23:31 INFO - 'HOME': '/home/cltbld', 00:23:31 INFO - 'LANG': 'en_US.UTF-8', 00:23:31 INFO - 'LANGUAGE': 'en_US:en', 00:23:31 INFO - 'LOGNAME': 'cltbld', 00:23:31 INFO - 'MAIL': '/var/mail/cltbld', 00:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:31 INFO - 'MOZ_NO_REMOTE': '1', 00:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:31 INFO - 'NO_EM_RESTART': '1', 00:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:31 INFO - 'PWD': '/builds/slave/test', 00:23:31 INFO - 'SHELL': '/bin/bash', 00:23:31 INFO - 'SHLVL': '1', 00:23:31 INFO - 'TERM': 'linux', 00:23:31 INFO - 'TMOUT': '86400', 00:23:31 INFO - 'USER': 'cltbld', 00:23:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:31 INFO - '_': '/tools/buildbot/bin/python'} 00:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:23:31 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 00:23:31 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 00:23:31 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 00:23:31 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 00:23:31 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 00:23:31 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 00:23:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:23:33 INFO - Installing collected packages: mozsystemmonitor 00:23:33 INFO - Running setup.py install for mozsystemmonitor 00:23:33 INFO - Successfully installed mozsystemmonitor 00:23:33 INFO - Cleaning up... 00:23:33 INFO - Return code: 0 00:23:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:23:33 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')]} 00:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:33 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')]} 00:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:33 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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:33 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 00:23:33 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 00:23:33 INFO - Using env: {'DISPLAY': ':0', 00:23:33 INFO - 'HOME': '/home/cltbld', 00:23:33 INFO - 'LANG': 'en_US.UTF-8', 00:23:33 INFO - 'LANGUAGE': 'en_US:en', 00:23:33 INFO - 'LOGNAME': 'cltbld', 00:23:33 INFO - 'MAIL': '/var/mail/cltbld', 00:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:33 INFO - 'MOZ_NO_REMOTE': '1', 00:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:33 INFO - 'NO_EM_RESTART': '1', 00:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:33 INFO - 'PWD': '/builds/slave/test', 00:23:33 INFO - 'SHELL': '/bin/bash', 00:23:33 INFO - 'SHLVL': '1', 00:23:33 INFO - 'TERM': 'linux', 00:23:33 INFO - 'TMOUT': '86400', 00:23:33 INFO - 'USER': 'cltbld', 00:23:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:33 INFO - '_': '/tools/buildbot/bin/python'} 00:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:34 INFO - Downloading/unpacking jsonschema==2.5.1 00:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:36 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:36 INFO - warning: no files found matching '*.txt' 00:23:36 INFO - no previously-included directories found matching 'build' 00:23:36 INFO - no previously-included directories found matching 'dist' 00:23:36 INFO - no previously-included directories found matching '.git*' 00:23:36 INFO - Installing collected packages: jsonschema, functools32 00:23:36 INFO - Running setup.py install for functools32 00:23:36 INFO - warning: no files found matching '*.txt' 00:23:36 INFO - no previously-included directories found matching 'build' 00:23:36 INFO - no previously-included directories found matching 'dist' 00:23:36 INFO - no previously-included directories found matching '.git*' 00:23:36 INFO - Successfully installed jsonschema functools32 00:23:36 INFO - Cleaning up... 00:23:36 INFO - Return code: 0 00:23:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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', '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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:23: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 blobuploader==1.2.4 00:23:36 INFO - Using env: {'DISPLAY': ':0', 00:23:36 INFO - 'HOME': '/home/cltbld', 00:23:36 INFO - 'LANG': 'en_US.UTF-8', 00:23:36 INFO - 'LANGUAGE': 'en_US:en', 00:23:36 INFO - 'LOGNAME': 'cltbld', 00:23:36 INFO - 'MAIL': '/var/mail/cltbld', 00:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:36 INFO - 'MOZ_NO_REMOTE': '1', 00:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:36 INFO - 'NO_EM_RESTART': '1', 00:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:36 INFO - 'PWD': '/builds/slave/test', 00:23:36 INFO - 'SHELL': '/bin/bash', 00:23:36 INFO - 'SHLVL': '1', 00:23:36 INFO - 'TERM': 'linux', 00:23:36 INFO - 'TMOUT': '86400', 00:23:36 INFO - 'USER': 'cltbld', 00:23:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:36 INFO - '_': '/tools/buildbot/bin/python'} 00:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:36 INFO - Downloading/unpacking blobuploader==1.2.4 00:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:38 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:38 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 00:23:38 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 00:23:38 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 00:23:38 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 00:23:38 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 00:23:38 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 00:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:39 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 00:23:39 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 00:23:39 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 00:23:39 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 00:23:39 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 00:23:39 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 00:23:39 INFO - Downloading docopt-0.6.1.tar.gz 00:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:39 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:39 INFO - Running setup.py install for blobuploader 00:23:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:39 INFO - Running setup.py install for requests 00:23:39 INFO - Running setup.py install for docopt 00:23:39 INFO - Successfully installed blobuploader requests docopt 00:23:39 INFO - Cleaning up... 00:23:40 INFO - Return code: 0 00:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:40 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')]} 00:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:40 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')]} 00:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:40 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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:40 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 00:23:40 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 00:23:40 INFO - Using env: {'DISPLAY': ':0', 00:23:40 INFO - 'HOME': '/home/cltbld', 00:23:40 INFO - 'LANG': 'en_US.UTF-8', 00:23:40 INFO - 'LANGUAGE': 'en_US:en', 00:23:40 INFO - 'LOGNAME': 'cltbld', 00:23:40 INFO - 'MAIL': '/var/mail/cltbld', 00:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:40 INFO - 'MOZ_NO_REMOTE': '1', 00:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:40 INFO - 'NO_EM_RESTART': '1', 00:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:40 INFO - 'PWD': '/builds/slave/test', 00:23:40 INFO - 'SHELL': '/bin/bash', 00:23:40 INFO - 'SHLVL': '1', 00:23:40 INFO - 'TERM': 'linux', 00:23:40 INFO - 'TMOUT': '86400', 00:23:40 INFO - 'USER': 'cltbld', 00:23:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:40 INFO - '_': '/tools/buildbot/bin/python'} 00:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:40 INFO - Running setup.py (path:/tmp/pip-pBFwFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:40 INFO - Running setup.py (path:/tmp/pip-icYCcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:40 INFO - Running setup.py (path:/tmp/pip-vzqrBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:40 INFO - Running setup.py (path:/tmp/pip-SCV_oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:40 INFO - Running setup.py (path:/tmp/pip-7rzWVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:40 INFO - Running setup.py (path:/tmp/pip-JEIcWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:40 INFO - Running setup.py (path:/tmp/pip-oAeV5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:40 INFO - Running setup.py (path:/tmp/pip-1holqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:40 INFO - Running setup.py (path:/tmp/pip-KRIJhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:40 INFO - Running setup.py (path:/tmp/pip-TnvpI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:40 INFO - Running setup.py (path:/tmp/pip-YK5QjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:41 INFO - Running setup.py (path:/tmp/pip-DAAo5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:41 INFO - Running setup.py (path:/tmp/pip-RzD_Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:41 INFO - Running setup.py (path:/tmp/pip-MNx74w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:41 INFO - Running setup.py (path:/tmp/pip-T9UhvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:41 INFO - Running setup.py (path:/tmp/pip-TD6QQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:41 INFO - Running setup.py (path:/tmp/pip-vnvs1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:41 INFO - Running setup.py install for manifestparser 00:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:41 INFO - Running setup.py install for mozcrash 00:23:41 INFO - Running setup.py install for mozdebug 00:23:41 INFO - Running setup.py install for mozdevice 00:23:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:41 INFO - Running setup.py install for mozfile 00:23:41 INFO - Running setup.py install for mozhttpd 00:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozinfo 00:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozInstall 00:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozleak 00:23:42 INFO - Running setup.py install for mozlog 00:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for moznetwork 00:23:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozprocess 00:23:42 INFO - Running setup.py install for mozprofile 00:23:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozrunner 00:23:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:42 INFO - Running setup.py install for mozscreenshot 00:23:43 INFO - Running setup.py install for moztest 00:23:43 INFO - Running setup.py install for mozversion 00:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:23:43 INFO - Cleaning up... 00:23:43 INFO - Return code: 0 00:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:43 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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:43 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 00:23:43 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 00:23:43 INFO - Using env: {'DISPLAY': ':0', 00:23:43 INFO - 'HOME': '/home/cltbld', 00:23:43 INFO - 'LANG': 'en_US.UTF-8', 00:23:43 INFO - 'LANGUAGE': 'en_US:en', 00:23:43 INFO - 'LOGNAME': 'cltbld', 00:23:43 INFO - 'MAIL': '/var/mail/cltbld', 00:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:43 INFO - 'MOZ_NO_REMOTE': '1', 00:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:43 INFO - 'NO_EM_RESTART': '1', 00:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:43 INFO - 'PWD': '/builds/slave/test', 00:23:43 INFO - 'SHELL': '/bin/bash', 00:23:43 INFO - 'SHLVL': '1', 00:23:43 INFO - 'TERM': 'linux', 00:23:43 INFO - 'TMOUT': '86400', 00:23:43 INFO - 'USER': 'cltbld', 00:23:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:43 INFO - '_': '/tools/buildbot/bin/python'} 00:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:43 INFO - Running setup.py (path:/tmp/pip-hezQls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:43 INFO - Running setup.py (path:/tmp/pip-VFh_9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:43 INFO - Running setup.py (path:/tmp/pip-ekzbPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:43 INFO - Running setup.py (path:/tmp/pip-e9NriQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:43 INFO - Running setup.py (path:/tmp/pip-yaCFDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:43 INFO - Running setup.py (path:/tmp/pip-IPqZcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:43 INFO - Running setup.py (path:/tmp/pip-R2dtJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:43 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)) 00:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:43 INFO - Running setup.py (path:/tmp/pip-tmStmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:44 INFO - Running setup.py (path:/tmp/pip-Rv0Np5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:44 INFO - Running setup.py (path:/tmp/pip-u9uJcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:44 INFO - Running setup.py (path:/tmp/pip-4dpO2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:44 INFO - Running setup.py (path:/tmp/pip-LFMhR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:44 INFO - Running setup.py (path:/tmp/pip-esnSaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:44 INFO - Running setup.py (path:/tmp/pip-OGmKQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:44 INFO - Running setup.py (path:/tmp/pip-SaoBDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:44 INFO - Running setup.py (path:/tmp/pip-RPc2IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:44 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)) 00:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:44 INFO - Running setup.py (path:/tmp/pip-KACus4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:44 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)) 00:23:44 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)) 00:23:44 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)) 00:23:44 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)) 00:23:44 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)) 00:23:44 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)) 00:23:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:44 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 00:23:46 INFO - Downloading blessings-1.6.tar.gz 00:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:23:46 INFO - Installing collected packages: blessings 00:23:46 INFO - Running setup.py install for blessings 00:23:46 INFO - Successfully installed blessings 00:23:46 INFO - Cleaning up... 00:23:46 INFO - Return code: 0 00:23:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:23:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:47 INFO - Reading from file tmpfile_stdout 00:23:47 INFO - Current package versions: 00:23:47 INFO - argparse == 1.2.1 00:23:47 INFO - blessings == 1.6 00:23:47 INFO - blobuploader == 1.2.4 00:23:47 INFO - docopt == 0.6.1 00:23:47 INFO - functools32 == 3.2.3-2 00:23:47 INFO - jsonschema == 2.5.1 00:23:47 INFO - manifestparser == 1.1 00:23:47 INFO - mozInstall == 1.12 00:23:47 INFO - mozcrash == 0.17 00:23:47 INFO - mozdebug == 0.1 00:23:47 INFO - mozdevice == 0.48 00:23:47 INFO - mozfile == 1.2 00:23:47 INFO - mozhttpd == 0.7 00:23:47 INFO - mozinfo == 0.9 00:23:47 INFO - mozleak == 0.1 00:23:47 INFO - mozlog == 3.2 00:23:47 INFO - moznetwork == 0.27 00:23:47 INFO - mozprocess == 0.23 00:23:47 INFO - mozprofile == 0.28 00:23:47 INFO - mozrunner == 6.12 00:23:47 INFO - mozscreenshot == 0.1 00:23:47 INFO - mozsystemmonitor == 0.3 00:23:47 INFO - moztest == 0.7 00:23:47 INFO - mozversion == 1.4 00:23:47 INFO - psutil == 3.1.1 00:23:47 INFO - requests == 1.2.3 00:23:47 INFO - wsgiref == 0.1.2 00:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:47 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')]} 00:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 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')]} 00:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:47 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 00:23:47 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 00:23:47 INFO - Using env: {'DISPLAY': ':0', 00:23:47 INFO - 'HOME': '/home/cltbld', 00:23:47 INFO - 'LANG': 'en_US.UTF-8', 00:23:47 INFO - 'LANGUAGE': 'en_US:en', 00:23:47 INFO - 'LOGNAME': 'cltbld', 00:23:47 INFO - 'MAIL': '/var/mail/cltbld', 00:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:47 INFO - 'MOZ_NO_REMOTE': '1', 00:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:47 INFO - 'NO_EM_RESTART': '1', 00:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:47 INFO - 'PWD': '/builds/slave/test', 00:23:47 INFO - 'SHELL': '/bin/bash', 00:23:47 INFO - 'SHLVL': '1', 00:23:47 INFO - 'TERM': 'linux', 00:23:47 INFO - 'TMOUT': '86400', 00:23:47 INFO - 'USER': 'cltbld', 00:23:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:47 INFO - '_': '/tools/buildbot/bin/python'} 00:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 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)) 00:23:47 INFO - Cleaning up... 00:23:47 INFO - Return code: 0 00:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:23:47 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')]} 00:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 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')]} 00:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:47 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 0x28b3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b74180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', '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 00:23:47 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 00:23:47 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 00:23:47 INFO - Using env: {'DISPLAY': ':0', 00:23:47 INFO - 'HOME': '/home/cltbld', 00:23:47 INFO - 'LANG': 'en_US.UTF-8', 00:23:47 INFO - 'LANGUAGE': 'en_US:en', 00:23:47 INFO - 'LOGNAME': 'cltbld', 00:23:47 INFO - 'MAIL': '/var/mail/cltbld', 00:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:47 INFO - 'MOZ_NO_REMOTE': '1', 00:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:47 INFO - 'NO_EM_RESTART': '1', 00:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:47 INFO - 'PWD': '/builds/slave/test', 00:23:47 INFO - 'SHELL': '/bin/bash', 00:23:47 INFO - 'SHLVL': '1', 00:23:47 INFO - 'TERM': 'linux', 00:23:47 INFO - 'TMOUT': '86400', 00:23:47 INFO - 'USER': 'cltbld', 00:23:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:47 INFO - '_': '/tools/buildbot/bin/python'} 00:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:23:47 INFO - Cleaning up... 00:23:47 INFO - Return code: 0 00:23:47 INFO - Running post-action listener: _resource_record_post_action 00:23:47 INFO - Running post-action listener: _start_resource_monitoring 00:23:47 INFO - Starting resource monitoring. 00:23:47 INFO - ##### 00:23:47 INFO - ##### Finished create-virtualenv step (success) 00:23:47 INFO - ##### 00:23:47 INFO - ##### 00:23:47 INFO - ##### Running install step. 00:23:47 INFO - ##### 00:23:47 INFO - Running pre-action listener: _resource_record_pre_action 00:23:47 INFO - Running main action method: install 00:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:47 INFO - Reading from file tmpfile_stdout 00:23:47 INFO - Detecting whether we're running mozinstall >=1.0... 00:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:23:47 INFO - Reading from file tmpfile_stdout 00:23:47 INFO - Output received: 00:23:47 INFO - Usage: mozinstall [options] installer 00:23:47 INFO - Options: 00:23:47 INFO - -h, --help show this help message and exit 00:23:47 INFO - -d DEST, --destination=DEST 00:23:47 INFO - Directory to install application into. [default: 00:23:47 INFO - "/builds/slave/test"] 00:23:47 INFO - --app=APP Application being installed. [default: firefox] 00:23:47 INFO - mkdir: /builds/slave/test/build/application 00:23:47 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'] 00:23:47 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 00:24:04 INFO - Reading from file tmpfile_stdout 00:24:04 INFO - Output received: 00:24:04 INFO - /builds/slave/test/build/application/firefox/firefox 00:24:04 INFO - Running post-action listener: _resource_record_post_action 00:24:04 INFO - ##### 00:24:04 INFO - ##### Finished install step (success) 00:24:04 INFO - ##### 00:24:04 INFO - ##### 00:24:04 INFO - ##### Running run-tests step. 00:24:04 INFO - ##### 00:24:04 INFO - Running pre-action listener: _resource_record_pre_action 00:24:04 INFO - Running main action method: run_tests 00:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:04 INFO - Python 2.7.3 00:24:04 INFO - Return code: 0 00:24:04 INFO - grabbing minidump binary from tooltool 00:24:04 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')]} 00:24:04 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 0x2b723b0>, '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 0x2b732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:04 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 00:24:04 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 00:24:04 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 00:24:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:04 INFO - Return code: 0 00:24:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:24:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:24:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:04 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/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 00:24:04 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/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 00:24:04 INFO - Using env: {'DISPLAY': ':0', 00:24:04 INFO - 'HOME': '/home/cltbld', 00:24:04 INFO - 'LANG': 'en_US.UTF-8', 00:24:04 INFO - 'LANGUAGE': 'en_US:en', 00:24:04 INFO - 'LOGNAME': 'cltbld', 00:24:04 INFO - 'MAIL': '/var/mail/cltbld', 00:24:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:04 INFO - 'MOZ_NO_REMOTE': '1', 00:24:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:04 INFO - 'NO_EM_RESTART': '1', 00:24:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:04 INFO - 'PWD': '/builds/slave/test', 00:24:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:04 INFO - 'SHELL': '/bin/bash', 00:24:04 INFO - 'SHLVL': '1', 00:24:04 INFO - 'TERM': 'linux', 00:24:04 INFO - 'TMOUT': '86400', 00:24:04 INFO - 'USER': 'cltbld', 00:24:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589', 00:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:04 INFO - '_': '/tools/buildbot/bin/python'} 00:24:04 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/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 00:24:04 INFO - mozversion application_buildid: 20160715230551 00:24:04 INFO - mozversion application_changeset: c47d2ca42dff8772f2e86be895ff331346a37b6c 00:24:04 INFO - mozversion application_display_name: Nightly 00:24:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:04 INFO - mozversion application_name: Firefox 00:24:04 INFO - mozversion application_remotingname: firefox 00:24:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:24:04 INFO - mozversion application_vendor: Mozilla 00:24:04 INFO - mozversion application_version: 50.0a1 00:24:04 INFO - mozversion platform_buildid: 20160715230551 00:24:04 INFO - mozversion platform_changeset: c47d2ca42dff8772f2e86be895ff331346a37b6c 00:24:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:24:04 INFO - mozversion platform_version: 50.0a1 00:24:04 INFO - using testdate: 1468653844 00:24:04 INFO - actual date: 1468653844 00:24:04 INFO - starting webserver on 'localhost:36374' 00:24:04 INFO - SUITE-START | Running 2 tests 00:24:04 INFO - TEST-START | dromaeo_css 00:24:04 INFO - operating with platform_type : linux_ 00:24:04 INFO - Initialising browser for dromaeo_css test... 00:24:04 INFO - TEST-INFO | started process 18045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenUWCS/profile http://localhost:36374/getInfo.html) 00:24:08 INFO - PROCESS | 18045 | __metrics Screen width/height:1600/1200 00:24:08 INFO - PROCESS | 18045 | colorDepth:24 00:24:08 INFO - PROCESS | 18045 | Browser inner width/height: 1024/697 00:24:08 INFO - PROCESS | 18045 | __metrics 00:24:09 INFO - PROCESS | 18045 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:24:09 INFO - PROCESS | 18045 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:24:10 INFO - PROCESS | 18045 | console.error: PushService: 00:24:10 INFO - PROCESS | 18045 | stateChangeProcessEnqueue: Error transitioning state 00:24:10 INFO - PROCESS | 18045 | UnknownError 00:24:10 INFO - TEST-INFO | 18045: exit 0 00:24:10 INFO - Browser initialized. 00:24:10 INFO - Running cycle 1/1 for dromaeo_css test... 00:24:10 INFO - TEST-INFO | started process 18125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenUWCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:22 INFO - PROCESS | 18125 | RSS: Main: 159019008 00:24:22 INFO - PROCESS | 18125 | 00:25:13 INFO - PROCESS | 18125 | 1468653913744 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] 00:27:26 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36374/tests/dromaeo/cssquery-ext.html) 00:27:27 INFO - PROCESS | 18125 | RSS: Main: 242556928 00:27:27 INFO - PROCESS | 18125 | 00:30:30 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-ext.html (next: http://localhost:36374/tests/dromaeo/cssquery-jquery.html) 00:30:31 INFO - PROCESS | 18125 | RSS: Main: 247808000 00:30:31 INFO - PROCESS | 18125 | 00:33:33 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36374/tests/dromaeo/cssquery-mootools.html) 00:33:34 INFO - PROCESS | 18125 | RSS: Main: 244912128 00:33:34 INFO - PROCESS | 18125 | 00:36:36 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36374/tests/dromaeo/cssquery-prototype.html) 00:36:37 INFO - PROCESS | 18125 | RSS: Main: 236670976 00:36:37 INFO - PROCESS | 18125 | 00:39:40 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36374/tests/dromaeo/cssquery-yui.html) 00:39:40 INFO - PROCESS | 18125 | RSS: Main: 225206272 00:39:40 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-yui.html (next: http://localhost:36374/tests/dromaeo/cssquery-dojo.html) 00:42:43 INFO - PROCESS | 18125 | RSS: Main: 283611136 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | __start_tp_report 00:42:43 INFO - PROCESS | 18125 | _x_x_mozilla_page_load 00:42:43 INFO - PROCESS | 18125 | _x_x_mozilla_page_load_details 00:42:43 INFO - PROCESS | 18125 | |i|pagename|runs| 00:42:43 INFO - PROCESS | 18125 | |0;dojo.html;2620.685517737871;2637.063842335972;2670.2389818901615;2677.41096958669;2682.4232789950156;4602.010567727938;4644;4746.264329028997;4874.829380971667;4920.926186107206;4717.716936983783;4755.096531658983;4776.689515181511;4792.976035119819;4804.495527969557;4187.769672668017;4360.67294952879;4441.5780500852525;4472.865814025568;4538.8865278367975;4443.089166720814;4473.172463094322;4496.235639941201;4498.212812757771;4525.864224073283;4315.654747620183;4366.170427618774;4370.322599997005;4409.140217657558;4419.955800442019;4342.5874541918465;4392.38506609075;4400.031992961543;4442.866713998553;4458.1306645204195;4391.978040109779;4432.645388368923;4440.533743956903;4481.887952801173;4489.416375871148;4664.207084795559;4731.621470282369;4817.156997525419;4840.903181936377;4842.854714358575;5200.167973124282;5233;5243.501867322599;5248.081585722483;5254.054270231357;5193.714345710984;5224.52979231871;5232.92150617741;5233.267342572043;5290.814821481268;4631.073785242931;4781.497942716034;4838.153323168432;4841.031793641286;4900.215965445512;5319.6808191508635;5329.946700532945;5360.731963401814;5365.463453654681;5367.141257398797;4854.878628034327;5074.188129899272;5084.288199652052;5131.7434128293435;5133.332666753373;4965.925511117336;4998.475160108209;5007.674501157413;5015.6489045767175;5029.044481548494;4976.2286845539;4984.850454486371;4994.225894986283;4995.875103122451;5033.974830125826;4954.281629163823;4967.130752118364;5001.8499445016705;5001.924971125436;5011.198208286657;4381.539938306496;4382.802773875183;4398.604125628709;4424.292113261927;4433.911321773547;3805.086779173034;3810.676092532166;3828.406596977473;3856.4986551748093;3856.903577410531;4268.743875367488;4315.4605674290715;4335.588119128678;4418.668599854959;4420.602145806893;5080.517350851663;5095.261187127846;5108.386993560722;5120.359955005624;5160.329157209539;4370.7159034662645;4376.868693939187;4382.035952090535;4420.80106395213;4424.668149888771;4397.186520493655;4429.313456414261;4433.645308375322;4600.240960241589;4611.446626404853;4554.111948170075;4617.053504031733;4620.838270660645;4621.4223222097235;4628.5371462853445;4898.387701537308;4928.581070609039;4933.703977761345;4936.8765780855765;4938.333325001079;4754.857354279377;4783.569478746929;4788.7366194859615;4841.298011788201;4841.491643377394;4939.802407903644;4982.551570358685;4985.451600324034;4992.201247800334;5002.299678045004;4890.926636100533;4939.75301234944;5053.292539044463;5063.518965698253;5105;4713.128071306819;4943.752812359296;4973.129702302011;4990.101781679187;4991.151504244214;4875.04936537386;4929.507049295042;4936.284238785428;4939.16034274167;4984.850454486371;4799.66402351832;4849.369581954324;4853.39332583427;4861.319415281934;4861.683990540603;4975.825846095369;5046.84859454217;5071.644984851025;5072.188449848154;5075.390953085654;4954.4797796232315;4954.752262386794;4960.8759781005765;4961.355023846877;5006.199008158677 00:42:43 INFO - PROCESS | 18125 | |1;ext.html;579.672485045949;585.6632436349098;593.7654626422564;596.1088173181095;602.3645054467538;40020;41536.58463415365;41726.58273417268;45377.31934020992;45412;41202.58797412025;41548.79225603875;41560.79219603898;41563;41624;7510.737124200654;7891.3292370148465;8011.439199256054;8025.0771161316325;10084.495775211246;9925.404475731442;10334.276600637959;10342.638007669733;10344.172466202723;10346.844797328045;10272.28094033418;10415.739606509822;10416.42709650969;10417.479126043705;10421.583136674524;7615.428842836782;10125.949370253174;10282.280240383176;10448.26862119652;10451.581936722521;10197.388156710622;10261.79476410475;10263.076323130954;10274.22943279257;10280.07479326864;39027;39484.407733884014;39497;39502.40746388806;39511.40732889009;2423.5395274897714;2869.297022229546;3249.3501299740146;3272.7709060365783;3832.6550610445192;28119.437611247864;30319.545206821917;30357.544636830466;30374.84812575923;30442.391152177053;3388.423967925459;3457.9123239716873;3461.4769501419296;3620.25784714133;3624.311380837659;264408;265021.67489162623;265538;266249;266971;46674.76662616733;53029;53127.468725313025;53355.73322133364;53393.46606533963;55808.72095639577;57789;57933.420665793645;62363.68818155971;62392.37607623956;14857.182854943081;14940.402383904739;15011.099334039993;15024.62438439026;15031.248437578077;10689.732756680989;11485.483153258123;11720.472578733978;11776.70558236051;12007.099467539794;16388.836111638968;16606.584835379213;16608;16631.6673666526;16652.50042498727;6192.783252586138;6265.525117578531;6406.031555821886;6433.292337842833;6490.675466226669;817.7710241132493;859.239572977919;872.807982243918;907.2877790934085;1005.1657124586576;27710.722892770813;28491.28771780722;28582.571261431094;28839.423211536072;28894.42211155765;1016.7712264740375;1022.504085518523;1031.9019693129142;1049.4437947887632;1073.9248252622242;14819.925900370428;15238.238088095552;15333.539993799981;15409.383624655113;15494.612634684223;351057;355059;356555;357199;357423;48943;49253.261201082016;49267.753661231465;49365.50634493609;49567;1089.3246187363884;1173.6537721372215;1216.6958260434892;1223.2415902140551;1223.290491514937;28019;29084.709152909047;29200.853995729885;29492.705072948997;29861.253468663457;41949;42168;42572.78713606412;42653;42765;292470;293465;293727;296003;296195;31146.532802007536;38513.80743096267;39741.60258397379;40082;40104.79947600243;41123.7943810279;41420.378694320214;41675.37486937638;41996.58003420049;42082.57917420909;35382;35493.64506354903;36399.81800090983;36564.81717591395;36676;35745;35852.64147358493;35940.64059359373;35966;36397;32323.51514727328;32361.676383235867;36219.818900905324;36942.630573694994;37100.44349334816;29282.267943300736;32327.35345293034;32839.34321313513;33112.1721956953;33353.83323083369;25052.874735626207;25215.495690086464;25440.007995602715;25762.742372576035;25948.48103037891 00:42:43 INFO - PROCESS | 18125 | |2;jquery.html;356.9072041269269;375.54558983629806;381.3307645082881;381.56882722523545;388.79976811941856;13066.15070020448;16562;17475.21361538732;18922;18966.81033189671;16562.254698538563;16571.337146514124;17327.393541226058;18270.17784199711;18644;4808.975955120228;5176.482351764831;5179.352580927384;5179.818706345279;5180.093483640367;3746.1758413149064;5050.595952323805;5616.129499927518;5901.3803550627;5913.615614985034;5962.910556341659;5963.791267305645;5982.132590774335;5983.461488466037;5988.8203353899235;5819.73811178498;6094.268687757453;6101.389861013908;6101.816945491642;6106.786262480814;3442.087846720596;5028.899422011576;5340.092184328673;5343.145096784496;5385.680508275458;21667.891660541598;22301.21945731908;22312;22354.552908941892;22516.549669006527;1968.0651690447066;2021.9696704549444;2080.6046851098245;2180.4766855954617;2454.5827209374447;13380.732385352336;13488.39302231402;13627.386767595483;14025.859741402659;14273.571792846127;1776.5292197567655;1844.6864033114268;1857.1735577667807;1866.216189200539;1920.836728878033;68991;69281;69721.65139174322;70439.29560704378;71741.64129179373;8772.78068048291;9732.41605503672;9877.950610246902;10196.643117490852;10258;12275.508979640894;13482.932585337207;13508.392122354519;14072;14077.225752583501;7228;7583.886241706268;7702.730404435818;7782.416318776114;7909.7231596893835;7367.336939675455;7499.962500187464;7517.398608111447;7727.613619319011;7745.07059152894;6251.468625166912;6372.171617689671;6413.198350206224;6487.967560162263;6503.975651322158;1673.6820004199408;1805.8374746272898;1825.415866922572;1829.7422813976234;1899.848012159024;708.596100222868;743.7099531182843;786.8701664225454;817.8282560662209;831.2766601945648;15779.05325680463;16217.837821621868;16385.016898986098;16486.587835303973;16780.412685555948;761.8514389694068;793.5833687314206;812.1675282835141;816.6978218059237;866.1944391715765;9055.728328150166;9232.90767092334;9381.5309234538;9386.389884657476;9606.615735370646;383412;385717;387287;389940;396004;84541.57729211314;85804.57097714471;87007;87450.56274718586;88905.55547222352;930.0885132569985;931.0735817861272;955.1117460761559;957.4446820843893;966.9564869580886;16158.434454794025;16519.3678092284;16736.916315418344;16911.323547058473;17024.404145854834;26829.865850670623;35669.286614267054;38201.808990954865;38655;40947.590524094376;53000.73499632477;53764;55397.16904246359;55653.443465566445;55724.72137639286;4440.6447484201835;6868.484863635347;6910.756063908545;7088.113985751781;7460.7015719372785;9826.508674566387;12005.699857503632;12540.24758514492;12675.112742107964;13070.150440221356;8245.51580715453;8289.378296627656;10345;10613.310134841211;10715.410652414192;10269.537870795682;10524.05305018574;10558.683239502827;10692.19808514349;10895.891041089804;9938.801223975624;10294.742631433974;10357.896421035693;10767.246292759744;11135.276207046516;8210.958945205235;8236.258736713724;8246;8301;8346.833063338821;9490.810183796148;10524.947375263075;10592.311499752492;10708.357498550113;11141.94151555601 00:42:43 INFO - PROCESS | 18125 | |3;mootools.html;1279.8400199975003;1394.281944798429;1427.7073199994002;1490.7912892195095;1735.1237624999374;6924.6883890224935;7852.646630901609;8114.269715725576;8115;8325.25072743453;8038;8225;8228.91771082289;8238.835223295531;8240.175982401772;2237.999999999996;2262.8189744820374;2266.3767463947465;2266.795988361047;2269.7503274639776;2200.273909609833;2232.2075663139594;2234.3967128875192;2236.0608544411307;2237.5524895021063;2182.5416662500893;2216.756156822756;2217.1353172262748;2218.3899427657443;2230.130249202812;2127.585120901425;2170.8371872109656;2174.152080688533;2181.6509358502562;2182.3998400439846;2174.836887233464;2177.9763511149895;2181.0588576167224;2181.727284089489;2182.1380554680973;8080.515169089815;8159;8189.549574773385;8220.219079187467;8435.029971553227;4816.060868130716;4946.480619534933;4948.257761335793;4950.950490495121;4952.455229924705;2993.745531629814;3065.1877252528097;3112.393083348748;3122.032170027276;3134.435801555719;915.6566287642135;930.3115694386173;934.219926361489;942.1285311087286;942.990570094304;11405.258658187191;11533.250338727956;11542.538298468051;11551.653450396501;11557.422128893522;3954.7824869632445;4105.958940410557;4199.265128602482;4211.389348544444;4263.2752432086;8919.777005574913;8920.73237802867;8963.372563920593;8973.775655608531;8973.820523589491;4716.103940251342;4719.174144524694;4726.172919739032;4735.976320118446;4739.099571081483;3570.839312230956;4196.328587426058;4369.60673539383;4378.671599629977;4425.668074894395;3581.585273816828;3583.2654305867236;3679;3687.1888184599347;3732.6080761520193;1072.8122578548723;1086.3916206923989;1091.8034753744403;1094.9397783122006;1101.498818037791;565.6912546803113;679.242644451443;706.3078183380316;742.840289337795;808.2039191396469;5127.717975511383;5249.47505249472;5267.446918073624;5335.519803217729;5413.83758487246;883.3021912688904;909.6370885654886;944.6882528765491;962.4802606592361;979.4319294808994;3360.9663903361143;3536.1336472564385;3563.7861728296384;3564.144605294711;3597.7661452005536;10029.548670309854;10365.118964888068;10513.106385957126;10539.104176145114;10553.155747540179;10240;10300.587976481007;10305.175585953106;10312.896871031344;10412.947935260427;7332.926670733331;7428.85142297151;7453.664585093684;7453.813654658677;7487.064116985377;5076.695398276115;5339.973300133474;5456.918146227889;5474.781008759605;5591.440855914539;8970.955145224232;9525.90474095278;9540.045995400404;9549.713508594754;9560.61757529691;9119.680811171576;9499.525023748924;9535.046495350409;9733.02669733021;9734.513274336114;6026.216591843032;6043.697815109315;6233.625982441068;6768.221654509597;6917.9308206917285;6594.967025164843;7659.846803064019;7691.88462173079;7708.344790692854;7715.498492597963;6543.509236807164;7046.436285097282;7089.432845372255;7204.3155900189395;7317.5609463432365;6982.546134501241;7051.647417628996;7086.433085353056;7163.570185788869;7223.638818059181;5962.135490353788;6330.8100756977365;6380.330065343072;6402.039694045744;6416.037594360883;4439.62263207631;4463.843765468193;4570.6800523963;4599.67802253839;4679.27471241958;4484.75333856641;4604.424446944132;4673.813047478063;4707.105649926503;4714.38712967312 00:42:43 INFO - PROCESS | 18125 | |4;prototype.html;300.9488386974214;302.83192827980474;315.4369450530803;315.715855729843;316.7133743961714;4945.258211268307;4986.177280748681;4999.275105109757;5015.072211640844;5021.146405111126;4655.976720116403;4746.90506189876;4790.7125572465675;4794.5205479452125;4942.233953737167;3712.3874560697454;3716.609755975611;3743.625637436262;3865.9806700966456;3874.1476875087437;3870.013146647601;3873.128546077124;3887;3901.08324543732;3916.1971795781938;3644.5808731995894;3844.5578758442716;3865.7100717446165;3875.903102422448;3887.581032922991;3796.4115562087923;3824.7513911595656;3841.67345775608;3844.192719528902;3852.287326844543;3328.151321413024;3333.916652083693;3357.2949680567112;3358.22760765023;3358.781679190869;4801.831935882262;4832.806687732486;4848.321235027099;4858.125537403266;4870.51449307961;4154.712039267836;4319.546447622985;4330.501992270898;4370.497392799805;4371.737695738266;5103.183490641517;5103.872403189913;5121.443234091016;5128.384593848725;5158.767855446514;3640.526731524911;3642.1258897864586;3661.2677464507206;3678.2459595782802;3681.4661874028384;5190.8183213587345;5344.278522399465;5394.811181608664;5418.539424148952;5444.7822087116465;3699.2231631357718;3712.9071773205346;3724.2365315110337;3729.776213427149;3755.248950209969;3771.717121215865;3777.206786574795;3777.206786574795;3793.829277682511;3799.2781371539318;4315.741055536678;4339.786708778545;4346.543612920661;4347.913041739147;4357.586029327209;4869.22092465211;5101.693898366036;5134.974325128351;5144.948550514522;5170.3278573785165;1195.9581414650445;1292.7479141567492;1306.399056434032;1309.6791286134958;1311.6524121107914;858.2361698088706;893.6246776353947;895.6283142495791;896.9775755606162;904.9185573298435;4510.932336014962;4513.593776560126;4533.591976722111;4541.364209010741;4549.499555048942;5314.335708036496;5318;5319.494648008433;5319.893602127936;5320.457067450473;4407.316865885793;4463.152001119777;4475.232283248099;4516.932246016312;4543.363929049936;2783.540715781873;2794.902178423745;2809.2415047936943;2819.1401622504923;2822.618946442204;4972.751362431936;4974.37820272466;4975.427825800007;4978.327925730053;5004.649674522821;5250;5380.488853558905;5391.35303763543;5395.676259424447;5410.377806552218;4888.462269150391;4906.803727850846;4939.653664509401;4954.628402869799;4997.925031124463;5039.521245481674;5265.473452654704;5269.78920843162;5323.787048518016;5325.041492531382;5117.872053198551;5119;5143.202803565453;5153.613478989016;5178.249153872592;4884.462709101925;4910.484399138182;4927.482614325444;4981.704756763195;5000.199968005102;3712.5173727415263;3728.6457786510236;3730.9440358394104;3734.3651579231055;3738.3457894867747;5030.220315851049;5341.359036915595;5348.893022139458;5353.571714262772;5362.65142765719;5163.845084647466;5175.870603234949;5176.818811341585;5179.378474583074;5216.5393689766925;5112.514311140436;5169.144398600507;5214.539928819937;5257.579393648422;5268.394134674561;4855.465898751064;4966.751662416792;5094.949050509447;5101.540861322499;5110.131277682728;5234.1102012657175;5259.579233661374;5262.657927234717;5271.077561426811;5274.208868669731;5149.201873709581;5149.9742501287255;5152.407473140487;5154.020736060136;5154.5103215194495 00:42:43 INFO - PROCESS | 18125 | |5;yui.html;675.425887995204;675.8344205669608;695.4992405468062;706.5442789400837;732.2348146187232;12135.817962730554;13290.136141150842;13296.933515332434;13315.400806963686;13322.40049197786;12617.621471355875;12905.1611645243;13007.349632518384;13027.218366897992;13038;793.7063286583972;799.9720009799659;804.5293503300576;806.6773290683744;807.5235610989515;628.9308176100625;766.9309762121408;792.3621484704811;795.3796039089519;797.2306724011328;832.4505826154739;834.6869923778584;836.8577341851869;837.7696133563257;838.5429940682312;645.5416654175494;825.6119623776815;827.3711978896052;827.6772058897066;827.9710210142646;578.7511370110851;594.7650677982173;595.074658905402;595.642614431342;599.2479438304943;13009.414576343992;13067.803982940264;13515.189088654712;13538.729225415436;13556.254406007665;12822;13215.33923303831;13304.20174789506;13365.198088114745;13535.32323383827;11863.644090677208;11905.940470297593;11915.404229788475;11959.820602690967;12477.50089996399;4228.539173404765;4237.55891045612;4254.127903779718;4278.208531421666;4303.978480107611;58487.415125849046;58925.70537147287;58945.705271473365;58972.41027589712;59089.40910590925;8398.538080405515;8604.5697715114;8631.180037896389;8656;8673.349498787617;16837.494875153767;16847.663046738995;16848.74726879098;18320.358787442376;18736.063196840376;7220.819479513054;7338.4496162788;7626.23737626244;7660.425468089916;7688.231176882379;3751.2122454284904;3874.283257597297;3919.000654833056;3921.8235179416993;3936.173403585279;2945.4403663304333;3045.680203578637;3046.817190968549;3051.4354844353866;3057.357954829466;513.335230876009;520.4171328112539;523.6203752279566;523.7512181713655;567.0983136812488;519.2030233591419;522.339240860312;528.5744975294848;537.9220013098079;566.3006187358609;8214.342852571779;8564.78942066993;8658.826823463496;8885.733427997171;8910.331725120643;473.3562355196929;482.76344591150786;510.57877251267854;537.7885423360175;546.4098773324799;3847.8653247136217;4016.7389119707127;4247.6389506892265;4274.465691788527;4275.508316543575;103478.48260758798;104534.47732761287;104620.47689761502;105303;107329;89649;90713.54643226742;91132;92844.53577732068;93057;78258.6087069561;78764;79049.20950790534;79902.20097799064;80454;7935.84128317442;8066.959665201636;8180.222878826502;8201.13888041747;8315.792105197177;47888.521114788404;48486.5151348482;49478;49820.750896245285;50379.49620503748;47389.104435822184;54039.18941215806;59746.701266493386;61190.69404652948;70836;12566.84224729894;12804.807927880904;12840.229586224856;12955.222686638832;13351.132176408502;12158.270503769802;13008.349582521025;13088.411021503865;13320.33398330099;13607.319634018457;11696.855987287156;11756.059515238589;12074.698132546757;12288.324142172267;12432.191907526343;11872.940635296769;11877.524899003944;12031;12054.15620906528;12381.504739810307;12314.261144331369;12508.812367814307;12641;12657.746845063231;12666.683332916382;8968;9178.449293042439;9326.72019839406;9406.717798466058;9434.95282523583;10256.538455769658;10520.842187367349;10595.735106622396;10684.09185219265;10707.839382409114 00:42:43 INFO - PROCESS | 18125 | __end_tp_report 00:42:43 INFO - PROCESS | 18125 | __start_cc_report 00:42:43 INFO - PROCESS | 18125 | _x_x_mozilla_cycle_collect,981 00:42:43 INFO - PROCESS | 18125 | __end_cc_report 00:42:43 INFO - PROCESS | 18125 | __startTimestamp1468654963810__endTimestamp 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | ------- Summary: start ------- 00:42:43 INFO - PROCESS | 18125 | Number of tests: 6 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#0] dojo.html Cycles:165 Average:4708.43 Median:4841.49 stddev:490.77 (10.1%) stddev-sans-first:464.14 00:42:43 INFO - PROCESS | 18125 | Values: 2620.7 2637.1 2670.2 2677.4 2682.4 4602.0 4644.0 4746.3 4874.8 4920.9 4717.7 4755.1 4776.7 4793.0 4804.5 4187.8 4360.7 4441.6 4472.9 4538.9 4443.1 4473.2 4496.2 4498.2 4525.9 4315.7 4366.2 4370.3 4409.1 4420.0 4342.6 4392.4 4400.0 4442.9 4458.1 4392.0 4432.6 4440.5 4481.9 4489.4 4664.2 4731.6 4817.2 4840.9 4842.9 5200.2 5233.0 5243.5 5248.1 5254.1 5193.7 5224.5 5232.9 5233.3 5290.8 4631.1 4781.5 4838.2 4841.0 4900.2 5319.7 5329.9 5360.7 5365.5 5367.1 4854.9 5074.2 5084.3 5131.7 5133.3 4965.9 4998.5 5007.7 5015.6 5029.0 4976.2 4984.9 4994.2 4995.9 5034.0 4954.3 4967.1 5001.8 5001.9 5011.2 4381.5 4382.8 4398.6 4424.3 4433.9 3805.1 3810.7 3828.4 3856.5 3856.9 4268.7 4315.5 4335.6 4418.7 4420.6 5080.5 5095.3 5108.4 5120.4 5160.3 4370.7 4376.9 4382.0 4420.8 4424.7 4397.2 4429.3 4433.6 4600.2 4611.4 4554.1 4617.1 4620.8 4621.4 4628.5 4898.4 4928.6 4933.7 4936.9 4938.3 4754.9 4783.6 4788.7 4841.3 4841.5 4939.8 4982.6 4985.5 4992.2 5002.3 4890.9 4939.8 5053.3 5063.5 5105.0 4713.1 4943.8 4973.1 4990.1 4991.2 4875.0 4929.5 4936.3 4939.2 4984.9 4799.7 4849.4 4853.4 4861.3 4861.7 4975.8 5046.8 5071.6 5072.2 5075.4 4954.5 4954.8 4960.9 4961.4 5006.2 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#1] ext.html Cycles:180 Average:47166.12 Median:33233.00 stddev:80453.81 (242.1%) stddev-sans-first:80603.46 00:42:43 INFO - PROCESS | 18125 | Values: 579.7 585.7 593.8 596.1 602.4 40020.0 41536.6 41726.6 45377.3 45412.0 41202.6 41548.8 41560.8 41563.0 41624.0 7510.7 7891.3 8011.4 8025.1 10084.5 9925.4 10334.3 10342.6 10344.2 10346.8 10272.3 10415.7 10416.4 10417.5 10421.6 7615.4 10125.9 10282.3 10448.3 10451.6 10197.4 10261.8 10263.1 10274.2 10280.1 39027.0 39484.4 39497.0 39502.4 39511.4 2423.5 2869.3 3249.4 3272.8 3832.7 28119.4 30319.5 30357.5 30374.8 30442.4 3388.4 3457.9 3461.5 3620.3 3624.3 264408.0 265021.7 265538.0 266249.0 266971.0 46674.8 53029.0 53127.5 53355.7 53393.5 55808.7 57789.0 57933.4 62363.7 62392.4 14857.2 14940.4 15011.1 15024.6 15031.2 10689.7 11485.5 11720.5 11776.7 12007.1 16388.8 16606.6 16608.0 16631.7 16652.5 6192.8 6265.5 6406.0 6433.3 6490.7 817.8 859.2 872.8 907.3 1005.2 27710.7 28491.3 28582.6 28839.4 28894.4 1016.8 1022.5 1031.9 1049.4 1073.9 14819.9 15238.2 15333.5 15409.4 15494.6 351057.0 355059.0 356555.0 357199.0 357423.0 48943.0 49253.3 49267.8 49365.5 49567.0 1089.3 1173.7 1216.7 1223.2 1223.3 28019.0 29084.7 29200.9 29492.7 29861.3 41949.0 42168.0 42572.8 42653.0 42765.0 292470.0 293465.0 293727.0 296003.0 296195.0 31146.5 38513.8 39741.6 40082.0 40104.8 41123.8 41420.4 41675.4 41996.6 42082.6 35382.0 35493.6 36399.8 36564.8 36676.0 35745.0 35852.6 35940.6 35966.0 36397.0 32323.5 32361.7 36219.8 36942.6 37100.4 29282.3 32327.4 32839.3 33112.2 33353.8 25052.9 25215.5 25440.0 25762.7 25948.5 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#2] jquery.html Cycles:180 Average:24937.27 Median:4918.94 stddev:64403.86 (1309.3%) stddev-sans-first:64558.08 00:42:43 INFO - PROCESS | 18125 | Values: 356.9 375.5 381.3 381.6 388.8 13066.2 16562.0 17475.2 18922.0 18966.8 16562.3 16571.3 17327.4 18270.2 18644.0 4809.0 5176.5 5179.4 5179.8 5180.1 3746.2 5050.6 5616.1 5901.4 5913.6 5962.9 5963.8 5982.1 5983.5 5988.8 5819.7 6094.3 6101.4 6101.8 6106.8 3442.1 5028.9 5340.1 5343.1 5385.7 21667.9 22301.2 22312.0 22354.6 22516.5 1968.1 2022.0 2080.6 2180.5 2454.6 13380.7 13488.4 13627.4 14025.9 14273.6 1776.5 1844.7 1857.2 1866.2 1920.8 68991.0 69281.0 69721.7 70439.3 71741.6 8772.8 9732.4 9878.0 10196.6 10258.0 12275.5 13482.9 13508.4 14072.0 14077.2 7228.0 7583.9 7702.7 7782.4 7909.7 7367.3 7500.0 7517.4 7727.6 7745.1 6251.5 6372.2 6413.2 6488.0 6504.0 1673.7 1805.8 1825.4 1829.7 1899.8 708.6 743.7 786.9 817.8 831.3 15779.1 16217.8 16385.0 16486.6 16780.4 761.9 793.6 812.2 816.7 866.2 9055.7 9232.9 9381.5 9386.4 9606.6 383412.0 385717.0 387287.0 389940.0 396004.0 84541.6 85804.6 87007.0 87450.6 88905.6 930.1 931.1 955.1 957.4 967.0 16158.4 16519.4 16736.9 16911.3 17024.4 26829.9 35669.3 38201.8 38655.0 40947.6 53000.7 53764.0 55397.2 55653.4 55724.7 4440.6 6868.5 6910.8 7088.1 7460.7 9826.5 12005.7 12540.2 12675.1 13070.2 8245.5 8289.4 10345.0 10613.3 10715.4 10269.5 10524.1 10558.7 10692.2 10895.9 9938.8 10294.7 10357.9 10767.2 11135.3 8211.0 8236.3 8246.0 8301.0 8346.8 9490.8 10524.9 10592.3 10708.4 11141.9 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#3] mootools.html Cycles:180 Average:5289.80 Median:4881.27 stddev:3057.16 (62.6%) stddev-sans-first:3050.88 00:42:43 INFO - PROCESS | 18125 | Values: 1279.8 1394.3 1427.7 1490.8 1735.1 6924.7 7852.6 8114.3 8115.0 8325.3 8038.0 8225.0 8228.9 8238.8 8240.2 2238.0 2262.8 2266.4 2266.8 2269.8 2200.3 2232.2 2234.4 2236.1 2237.6 2182.5 2216.8 2217.1 2218.4 2230.1 2127.6 2170.8 2174.2 2181.7 2182.4 2174.8 2178.0 2181.1 2181.7 2182.1 8080.5 8159.0 8189.5 8220.2 8435.0 4816.1 4946.5 4948.3 4951.0 4952.5 2993.7 3065.2 3112.4 3122.0 3134.4 915.7 930.3 934.2 942.1 943.0 11405.3 11533.3 11542.5 11551.7 11557.4 3954.8 4106.0 4199.3 4211.4 4263.3 8919.8 8920.7 8963.4 8973.8 8973.8 4716.1 4719.2 4726.2 4736.0 4739.1 3570.8 4196.3 4369.6 4378.7 4425.7 3581.6 3583.3 3679.0 3687.2 3732.6 1072.8 1086.4 1091.8 1094.9 1101.5 565.7 679.2 706.3 742.8 808.2 5127.7 5249.5 5267.4 5335.5 5413.8 883.3 909.6 944.7 962.5 979.4 3361.0 3536.1 3563.8 3564.1 3597.8 10029.5 10365.1 10513.1 10539.1 10553.2 10240.0 10300.6 10305.2 10312.9 10412.9 7332.9 7428.9 7453.7 7453.8 7487.1 5076.7 5340.0 5456.9 5474.8 5591.4 8971.0 9525.9 9540.0 9549.7 9560.6 9119.7 9499.5 9535.0 9733.0 9734.5 6026.2 6043.7 6233.6 6768.2 6917.9 6595.0 7659.8 7691.9 7708.3 7715.5 6543.5 7046.4 7089.4 7204.3 7317.6 6982.5 7051.6 7086.4 7163.6 7223.6 5962.1 6330.8 6380.3 6402.0 6416.0 4439.6 4463.8 4570.7 4599.7 4679.3 4484.8 4604.4 4673.8 4707.1 4714.4 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#4] prototype.html Cycles:180 Average:4270.96 Median:4877.49 stddev:1243.89 (25.5%) stddev-sans-first:1211.16 00:42:43 INFO - PROCESS | 18125 | Values: 300.9 302.8 315.4 315.7 316.7 4945.3 4986.2 4999.3 5015.1 5021.1 4656.0 4746.9 4790.7 4794.5 4942.2 3712.4 3716.6 3743.6 3866.0 3874.1 3870.0 3873.1 3887.0 3901.1 3916.2 3644.6 3844.6 3865.7 3875.9 3887.6 3796.4 3824.8 3841.7 3844.2 3852.3 3328.2 3333.9 3357.3 3358.2 3358.8 4801.8 4832.8 4848.3 4858.1 4870.5 4154.7 4319.5 4330.5 4370.5 4371.7 5103.2 5103.9 5121.4 5128.4 5158.8 3640.5 3642.1 3661.3 3678.2 3681.5 5190.8 5344.3 5394.8 5418.5 5444.8 3699.2 3712.9 3724.2 3729.8 3755.2 3771.7 3777.2 3777.2 3793.8 3799.3 4315.7 4339.8 4346.5 4347.9 4357.6 4869.2 5101.7 5135.0 5144.9 5170.3 1196.0 1292.7 1306.4 1309.7 1311.7 858.2 893.6 895.6 897.0 904.9 4510.9 4513.6 4533.6 4541.4 4549.5 5314.3 5318.0 5319.5 5319.9 5320.5 4407.3 4463.2 4475.2 4516.9 4543.4 2783.5 2794.9 2809.2 2819.1 2822.6 4972.8 4974.4 4975.4 4978.3 5004.6 5250.0 5380.5 5391.4 5395.7 5410.4 4888.5 4906.8 4939.7 4954.6 4997.9 5039.5 5265.5 5269.8 5323.8 5325.0 5117.9 5119.0 5143.2 5153.6 5178.2 4884.5 4910.5 4927.5 4981.7 5000.2 3712.5 3728.6 3730.9 3734.4 3738.3 5030.2 5341.4 5348.9 5353.6 5362.7 5163.8 5175.9 5176.8 5179.4 5216.5 5112.5 5169.1 5214.5 5257.6 5268.4 4855.5 4966.8 5094.9 5101.5 5110.1 5234.1 5259.6 5262.7 5271.1 5274.2 5149.2 5150.0 5152.4 5154.0 5154.5 00:42:43 INFO - PROCESS | 18125 | 00:42:43 INFO - PROCESS | 18125 | [#5] yui.html Cycles:180 Average:18369.96 Median:49649.38 stddev:26634.63 (53.6%) stddev-sans-first:26676.21 00:42:43 INFO - PROCESS | 18125 | Values: 675.4 675.8 695.5 706.5 732.2 12135.8 13290.1 13296.9 13315.4 13322.4 12617.6 12905.2 13007.3 13027.2 13038.0 793.7 800.0 804.5 806.7 807.5 628.9 766.9 792.4 795.4 797.2 832.5 834.7 836.9 837.8 838.5 645.5 825.6 827.4 827.7 828.0 578.8 594.8 595.1 595.6 599.2 13009.4 13067.8 13515.2 13538.7 13556.3 12822.0 13215.3 13304.2 13365.2 13535.3 11863.6 11905.9 11915.4 11959.8 12477.5 4228.5 4237.6 4254.1 4278.2 4304.0 58487.4 58925.7 58945.7 58972.4 59089.4 8398.5 8604.6 8631.2 8656.0 8673.3 16837.5 16847.7 16848.7 18320.4 18736.1 7220.8 7338.4 7626.2 7660.4 7688.2 3751.2 3874.3 3919.0 3921.8 3936.2 2945.4 3045.7 3046.8 3051.4 3057.4 513.3 520.4 523.6 523.8 567.1 519.2 522.3 528.6 537.9 566.3 8214.3 8564.8 8658.8 8885.7 8910.3 473.4 482.8 510.6 537.8 546.4 3847.9 4016.7 4247.6 4274.5 4275.5 103478.5 104534.5 104620.5 105303.0 107329.0 89649.0 90713.5 91132.0 92844.5 93057.0 78258.6 78764.0 79049.2 79902.2 80454.0 7935.8 8067.0 8180.2 8201.1 8315.8 47888.5 48486.5 49478.0 49820.8 50379.5 47389.1 54039.2 59746.7 61190.7 70836.0 12566.8 12804.8 12840.2 12955.2 13351.1 12158.3 13008.3 13088.4 13320.3 13607.3 11696.9 11756.1 12074.7 12288.3 12432.2 11872.9 11877.5 12031.0 12054.2 12381.5 12314.3 12508.8 12641.0 12657.7 12666.7 8968.0 9178.4 9326.7 9406.7 9435.0 10256.5 10520.8 10595.7 10684.1 10707.8 00:42:43 INFO - PROCESS | 18125 | -------- Summary: end -------- 00:42:43 INFO - PROCESS | 18125 | 00:42:44 INFO - TEST-INFO | 18125: exit 0 00:42:44 INFO - TEST-OK | dromaeo_css | took 1120128ms 00:42:44 INFO - TEST-START | kraken 00:42:44 INFO - operating with platform_type : linux_ 00:42:44 INFO - Initialising browser for kraken test... 00:42:44 INFO - TEST-INFO | started process 18309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWYdMIQ/profile http://localhost:36374/getInfo.html) 00:42:49 INFO - PROCESS | 18309 | __metrics Screen width/height:1600/1200 00:42:49 INFO - PROCESS | 18309 | colorDepth:24 00:42:49 INFO - PROCESS | 18309 | Browser inner width/height: 1024/697 00:42:49 INFO - PROCESS | 18309 | __metrics 00:42:49 INFO - PROCESS | 18309 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:42:49 INFO - PROCESS | 18309 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:42:50 INFO - TEST-INFO | 18309: exit 0 00:42:50 INFO - Browser initialized. 00:42:50 INFO - Running cycle 1/1 for kraken test... 00:42:50 INFO - TEST-INFO | started process 18390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWYdMIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:02 INFO - PROCESS | 18390 | RSS: Main: 159313920 00:43:02 INFO - PROCESS | 18390 | 00:43:05 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:06 INFO - PROCESS | 18390 | RSS: Main: 217743360 00:43:06 INFO - PROCESS | 18390 | 00:43:09 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-dft) 00:43:09 INFO - PROCESS | 18390 | RSS: Main: 206675968 00:43:09 INFO - PROCESS | 18390 | 00:43:13 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-fft) 00:43:13 INFO - PROCESS | 18390 | RSS: Main: 272297984 00:43:13 INFO - PROCESS | 18390 | 00:43:15 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-oscillator) 00:43:16 INFO - PROCESS | 18390 | RSS: Main: 181760000 00:43:16 INFO - PROCESS | 18390 | 00:43:18 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:43:19 INFO - PROCESS | 18390 | RSS: Main: 185647104 00:43:19 INFO - PROCESS | 18390 | 00:43:22 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-darkroom) 00:43:23 INFO - PROCESS | 18390 | RSS: Main: 222531584 00:43:23 INFO - PROCESS | 18390 | 00:43:26 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-desaturate) 00:43:27 INFO - PROCESS | 18390 | RSS: Main: 218390528 00:43:27 INFO - PROCESS | 18390 | 00:43:30 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36374/tests/kraken/driver.html?testName=json-parse-financial) 00:43:30 INFO - PROCESS | 18390 | RSS: Main: 221061120 00:43:30 INFO - PROCESS | 18390 | 00:43:32 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:43:33 INFO - PROCESS | 18390 | RSS: Main: 209809408 00:43:33 INFO - PROCESS | 18390 | 00:43:34 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:43:35 INFO - PROCESS | 18390 | RSS: Main: 215068672 00:43:35 INFO - PROCESS | 18390 | 00:43:37 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:43:38 INFO - PROCESS | 18390 | RSS: Main: 211419136 00:43:38 INFO - PROCESS | 18390 | 00:43:41 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:43:41 INFO - PROCESS | 18390 | RSS: Main: 224911360 00:43:41 INFO - PROCESS | 18390 | 00:43:44 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:45 INFO - PROCESS | 18390 | RSS: Main: 224559104 00:43:45 INFO - PROCESS | 18390 | 00:43:46 INFO - PROCESS | 18390 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36374/tests/kraken/driver.html?testName=ai-astar) 00:43:47 INFO - PROCESS | 18390 | RSS: Main: 267378688 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | __start_tp_report 00:43:47 INFO - PROCESS | 18390 | _x_x_mozilla_page_load 00:43:47 INFO - PROCESS | 18390 | _x_x_mozilla_page_load_details 00:43:47 INFO - PROCESS | 18390 | |i|pagename|runs| 00:43:47 INFO - PROCESS | 18390 | |0;ai-astar;105;115;114;117;115;116;115;114;117;114 00:43:47 INFO - PROCESS | 18390 | |1;audio-beat-detection;146;122;123;175;123;129;156;121;193;124 00:43:47 INFO - PROCESS | 18390 | |2;audio-dft;162;161;169;161;161;162;161;162;162;161 00:43:47 INFO - PROCESS | 18390 | |3;audio-fft;77;75;77;105;76;77;74;76;100;76 00:43:47 INFO - PROCESS | 18390 | |4;audio-oscillator;87;87;129;84;85;85;130;85;93;120 00:43:47 INFO - PROCESS | 18390 | |5;imaging-gaussian-blur;117;117;116;116;116;117;116;116;117;117 00:43:47 INFO - PROCESS | 18390 | |6;imaging-darkroom;146;146;147;147;146;147;147;145;146;147 00:43:47 INFO - PROCESS | 18390 | |7;imaging-desaturate;95;95;95;95;94;96;95;95;96;95 00:43:47 INFO - PROCESS | 18390 | |8;json-parse-financial;68;61;63;63;61;61;61;61;65;62 00:43:47 INFO - PROCESS | 18390 | |9;json-stringify-tinderbox;65;66;66;66;66;66;65;65;66;67 00:43:47 INFO - PROCESS | 18390 | |10;stanford-crypto-aes;78;78;85;81;84;79;81;83;79;85 00:43:47 INFO - PROCESS | 18390 | |11;stanford-crypto-ccm;128;127;135;131;131;150;131;127;172;130 00:43:47 INFO - PROCESS | 18390 | |12;stanford-crypto-pbkdf2;171;167;163;163;163;164;163;165;163;163 00:43:47 INFO - PROCESS | 18390 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;67;65;66;66;64 00:43:47 INFO - PROCESS | 18390 | __end_tp_report 00:43:47 INFO - PROCESS | 18390 | __start_cc_report 00:43:47 INFO - PROCESS | 18390 | _x_x_mozilla_cycle_collect,1905 00:43:47 INFO - PROCESS | 18390 | __end_cc_report 00:43:47 INFO - PROCESS | 18390 | __startTimestamp1468655027128__endTimestamp 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | ------- Summary: start ------- 00:43:47 INFO - PROCESS | 18390 | Number of tests: 14 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:3.43 (3.0%) stddev-sans-first:1.20 00:43:47 INFO - PROCESS | 18390 | Values: 105.0 115.0 114.0 117.0 115.0 116.0 115.0 114.0 117.0 114.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:137.50 stddev:25.72 (18.7%) stddev-sans-first:27.22 00:43:47 INFO - PROCESS | 18390 | Values: 146.0 122.0 123.0 175.0 123.0 129.0 156.0 121.0 193.0 124.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.44 (1.5%) stddev-sans-first:2.59 00:43:47 INFO - PROCESS | 18390 | Values: 162.0 161.0 169.0 161.0 161.0 162.0 161.0 162.0 162.0 161.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.27 (14.8%) stddev-sans-first:11.85 00:43:47 INFO - PROCESS | 18390 | Values: 77.0 75.0 77.0 105.0 76.0 77.0 74.0 76.0 100.0 76.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:85.00 stddev:19.54 (23.0%) stddev-sans-first:20.28 00:43:47 INFO - PROCESS | 18390 | Values: 87.0 87.0 129.0 84.0 85.0 85.0 130.0 85.0 93.0 120.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:43:47 INFO - PROCESS | 18390 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:43:47 INFO - PROCESS | 18390 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 145.0 146.0 147.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 00:43:47 INFO - PROCESS | 18390 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:62.50 stddev:2.32 (3.7%) stddev-sans-first:1.41 00:43:47 INFO - PROCESS | 18390 | Values: 68.0 61.0 63.0 63.0 61.0 61.0 61.0 61.0 65.0 62.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 00:43:47 INFO - PROCESS | 18390 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 67.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:2.79 (3.4%) stddev-sans-first:2.69 00:43:47 INFO - PROCESS | 18390 | Values: 78.0 78.0 85.0 81.0 84.0 79.0 81.0 83.0 79.0 85.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:131.00 stddev:14.26 (10.9%) stddev-sans-first:14.81 00:43:47 INFO - PROCESS | 18390 | Values: 128.0 127.0 135.0 131.0 131.0 150.0 131.0 127.0 172.0 130.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:163.50 stddev:2.64 (1.6%) stddev-sans-first:1.39 00:43:47 INFO - PROCESS | 18390 | Values: 171.0 167.0 163.0 163.0 163.0 164.0 163.0 165.0 163.0 163.0 00:43:47 INFO - PROCESS | 18390 | 00:43:47 INFO - PROCESS | 18390 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 00:43:47 INFO - PROCESS | 18390 | Values: 67.0 67.0 67.0 66.0 66.0 67.0 65.0 66.0 66.0 64.0 00:43:47 INFO - PROCESS | 18390 | -------- Summary: end -------- 00:43:47 INFO - PROCESS | 18390 | 00:43:48 INFO - TEST-INFO | 18390: exit 0 00:43:48 INFO - TEST-OK | kraken | took 63525ms 00:43:48 INFO - SUITE-END | took 1183s 00:43:48 INFO - Completed test suite (00:19:43) 00:43:48 INFO - javascript benchmark 00:43:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.685517737871, 2637.063842335972, 2670.2389818901615, 2677.41096958669, 2682.4232789950156, 4602.010567727938, 4644.0, 4746.264329028997, 4874.829380971667, 4920.926186107206, 4717.716936983783, 4755.096531658983, 4776.689515181511, 4792.976035119819, 4804.495527969557, 4187.769672668017, 4360.67294952879, 4441.5780500852525, 4472.865814025568, 4538.8865278367975, 4443.089166720814, 4473.172463094322, 4496.235639941201, 4498.212812757771, 4525.864224073283, 4315.654747620183, 4366.170427618774, 4370.322599997005, 4409.140217657558, 4419.955800442019, 4342.5874541918465, 4392.38506609075, 4400.031992961543, 4442.866713998553, 4458.1306645204195, 4391.978040109779, 4432.645388368923, 4440.533743956903, 4481.887952801173, 4489.416375871148, 4664.207084795559, 4731.621470282369, 4817.156997525419, 4840.903181936377, 4842.854714358575, 5200.167973124282, 5233.0, 5243.501867322599, 5248.081585722483, 5254.054270231357, 5193.714345710984, 5224.52979231871, 5232.92150617741, 5233.267342572043, 5290.814821481268, 4631.073785242931, 4781.497942716034, 4838.153323168432, 4841.031793641286, 4900.215965445512, 5319.6808191508635, 5329.946700532945, 5360.731963401814, 5365.463453654681, 5367.141257398797, 4854.878628034327, 5074.188129899272, 5084.288199652052, 5131.7434128293435, 5133.332666753373, 4965.925511117336, 4998.475160108209, 5007.674501157413, 5015.6489045767175, 5029.044481548494, 4976.2286845539, 4984.850454486371, 4994.225894986283, 4995.875103122451, 5033.974830125826, 4954.281629163823, 4967.130752118364, 5001.8499445016705, 5001.924971125436, 5011.198208286657, 4381.539938306496, 4382.802773875183, 4398.604125628709, 4424.292113261927, 4433.911321773547, 3805.086779173034, 3810.676092532166, 3828.406596977473, 3856.4986551748093, 3856.903577410531, 4268.743875367488, 4315.4605674290715, 4335.588119128678, 4418.668599854959, 4420.602145806893, 5080.517350851663, 5095.261187127846, 5108.386993560722, 5120.359955005624, 5160.329157209539, 4370.7159034662645, 4376.868693939187, 4382.035952090535, 4420.80106395213, 4424.668149888771, 4397.186520493655, 4429.313456414261, 4433.645308375322, 4600.240960241589, 4611.446626404853, 4554.111948170075, 4617.053504031733, 4620.838270660645, 4621.4223222097235, 4628.5371462853445, 4898.387701537308, 4928.581070609039, 4933.703977761345, 4936.8765780855765, 4938.333325001079, 4754.857354279377, 4783.569478746929, 4788.7366194859615, 4841.298011788201, 4841.491643377394, 4939.802407903644, 4982.551570358685, 4985.451600324034, 4992.201247800334, 5002.299678045004, 4890.926636100533, 4939.75301234944, 5053.292539044463, 5063.518965698253, 5105.0, 4713.128071306819, 4943.752812359296, 4973.129702302011, 4990.101781679187, 4991.151504244214, 4875.04936537386, 4929.507049295042, 4936.284238785428, 4939.16034274167, 4984.850454486371, 4799.66402351832, 4849.369581954324, 4853.39332583427, 4861.319415281934, 4861.683990540603, 4975.825846095369, 5046.84859454217, 5071.644984851025, 5072.188449848154, 5075.390953085654, 4954.4797796232315, 4954.752262386794, 4960.8759781005765, 4961.355023846877, 5006.199008158677], "value": 4677.422271632297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.672485045949, 585.6632436349098, 593.7654626422564, 596.1088173181095, 602.3645054467538, 40020.0, 41536.58463415365, 41726.58273417268, 45377.31934020992, 45412.0, 41202.58797412025, 41548.79225603875, 41560.79219603898, 41563.0, 41624.0, 7510.737124200654, 7891.3292370148465, 8011.439199256054, 8025.0771161316325, 10084.495775211246, 9925.404475731442, 10334.276600637959, 10342.638007669733, 10344.172466202723, 10346.844797328045, 10272.28094033418, 10415.739606509822, 10416.42709650969, 10417.479126043705, 10421.583136674524, 7615.428842836782, 10125.949370253174, 10282.280240383176, 10448.26862119652, 10451.581936722521, 10197.388156710622, 10261.79476410475, 10263.076323130954, 10274.22943279257, 10280.07479326864, 39027.0, 39484.407733884014, 39497.0, 39502.40746388806, 39511.40732889009, 2423.5395274897714, 2869.297022229546, 3249.3501299740146, 3272.7709060365783, 3832.6550610445192, 28119.437611247864, 30319.545206821917, 30357.544636830466, 30374.84812575923, 30442.391152177053, 3388.423967925459, 3457.9123239716873, 3461.4769501419296, 3620.25784714133, 3624.311380837659, 264408.0, 265021.67489162623, 265538.0, 266249.0, 266971.0, 46674.76662616733, 53029.0, 53127.468725313025, 53355.73322133364, 53393.46606533963, 55808.72095639577, 57789.0, 57933.420665793645, 62363.68818155971, 62392.37607623956, 14857.182854943081, 14940.402383904739, 15011.099334039993, 15024.62438439026, 15031.248437578077, 10689.732756680989, 11485.483153258123, 11720.472578733978, 11776.70558236051, 12007.099467539794, 16388.836111638968, 16606.584835379213, 16608.0, 16631.6673666526, 16652.50042498727, 6192.783252586138, 6265.525117578531, 6406.031555821886, 6433.292337842833, 6490.675466226669, 817.7710241132493, 859.239572977919, 872.807982243918, 907.2877790934085, 1005.1657124586576, 27710.722892770813, 28491.28771780722, 28582.571261431094, 28839.423211536072, 28894.42211155765, 1016.7712264740375, 1022.504085518523, 1031.9019693129142, 1049.4437947887632, 1073.9248252622242, 14819.925900370428, 15238.238088095552, 15333.539993799981, 15409.383624655113, 15494.612634684223, 351057.0, 355059.0, 356555.0, 357199.0, 357423.0, 48943.0, 49253.261201082016, 49267.753661231465, 49365.50634493609, 49567.0, 1089.3246187363884, 1173.6537721372215, 1216.6958260434892, 1223.2415902140551, 1223.290491514937, 28019.0, 29084.709152909047, 29200.853995729885, 29492.705072948997, 29861.253468663457, 41949.0, 42168.0, 42572.78713606412, 42653.0, 42765.0, 292470.0, 293465.0, 293727.0, 296003.0, 296195.0, 31146.532802007536, 38513.80743096267, 39741.60258397379, 40082.0, 40104.79947600243, 41123.7943810279, 41420.378694320214, 41675.37486937638, 41996.58003420049, 42082.57917420909, 35382.0, 35493.64506354903, 36399.81800090983, 36564.81717591395, 36676.0, 35745.0, 35852.64147358493, 35940.64059359373, 35966.0, 36397.0, 32323.51514727328, 32361.676383235867, 36219.818900905324, 36942.630573694994, 37100.44349334816, 29282.267943300736, 32327.35345293034, 32839.34321313513, 33112.1721956953, 33353.83323083369, 25052.874735626207, 25215.495690086464, 25440.007995602715, 25762.742372576035, 25948.48103037891], "value": 18373.266244946582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.9072041269269, 375.54558983629806, 381.3307645082881, 381.56882722523545, 388.79976811941856, 13066.15070020448, 16562.0, 17475.21361538732, 18922.0, 18966.81033189671, 16562.254698538563, 16571.337146514124, 17327.393541226058, 18270.17784199711, 18644.0, 4808.975955120228, 5176.482351764831, 5179.352580927384, 5179.818706345279, 5180.093483640367, 3746.1758413149064, 5050.595952323805, 5616.129499927518, 5901.3803550627, 5913.615614985034, 5962.910556341659, 5963.791267305645, 5982.132590774335, 5983.461488466037, 5988.8203353899235, 5819.73811178498, 6094.268687757453, 6101.389861013908, 6101.816945491642, 6106.786262480814, 3442.087846720596, 5028.899422011576, 5340.092184328673, 5343.145096784496, 5385.680508275458, 21667.891660541598, 22301.21945731908, 22312.0, 22354.552908941892, 22516.549669006527, 1968.0651690447066, 2021.9696704549444, 2080.6046851098245, 2180.4766855954617, 2454.5827209374447, 13380.732385352336, 13488.39302231402, 13627.386767595483, 14025.859741402659, 14273.571792846127, 1776.5292197567655, 1844.6864033114268, 1857.1735577667807, 1866.216189200539, 1920.836728878033, 68991.0, 69281.0, 69721.65139174322, 70439.29560704378, 71741.64129179373, 8772.78068048291, 9732.41605503672, 9877.950610246902, 10196.643117490852, 10258.0, 12275.508979640894, 13482.932585337207, 13508.392122354519, 14072.0, 14077.225752583501, 7228.0, 7583.886241706268, 7702.730404435818, 7782.416318776114, 7909.7231596893835, 7367.336939675455, 7499.962500187464, 7517.398608111447, 7727.613619319011, 7745.07059152894, 6251.468625166912, 6372.171617689671, 6413.198350206224, 6487.967560162263, 6503.975651322158, 1673.6820004199408, 1805.8374746272898, 1825.415866922572, 1829.7422813976234, 1899.848012159024, 708.596100222868, 743.7099531182843, 786.8701664225454, 817.8282560662209, 831.2766601945648, 15779.05325680463, 16217.837821621868, 16385.016898986098, 16486.587835303973, 16780.412685555948, 761.8514389694068, 793.5833687314206, 812.1675282835141, 816.6978218059237, 866.1944391715765, 9055.728328150166, 9232.90767092334, 9381.5309234538, 9386.389884657476, 9606.615735370646, 383412.0, 385717.0, 387287.0, 389940.0, 396004.0, 84541.57729211314, 85804.57097714471, 87007.0, 87450.56274718586, 88905.55547222352, 930.0885132569985, 931.0735817861272, 955.1117460761559, 957.4446820843893, 966.9564869580886, 16158.434454794025, 16519.3678092284, 16736.916315418344, 16911.323547058473, 17024.404145854834, 26829.865850670623, 35669.286614267054, 38201.808990954865, 38655.0, 40947.590524094376, 53000.73499632477, 53764.0, 55397.16904246359, 55653.443465566445, 55724.72137639286, 4440.6447484201835, 6868.484863635347, 6910.756063908545, 7088.113985751781, 7460.7015719372785, 9826.508674566387, 12005.699857503632, 12540.24758514492, 12675.112742107964, 13070.150440221356, 8245.51580715453, 8289.378296627656, 10345.0, 10613.310134841211, 10715.410652414192, 10269.537870795682, 10524.05305018574, 10558.683239502827, 10692.19808514349, 10895.891041089804, 9938.801223975624, 10294.742631433974, 10357.896421035693, 10767.246292759744, 11135.276207046516, 8210.958945205235, 8236.258736713724, 8246.0, 8301.0, 8346.833063338821, 9490.810183796148, 10524.947375263075, 10592.311499752492, 10708.357498550113, 11141.94151555601], "value": 8506.885453082115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.8400199975003, 1394.281944798429, 1427.7073199994002, 1490.7912892195095, 1735.1237624999374, 6924.6883890224935, 7852.646630901609, 8114.269715725576, 8115.0, 8325.25072743453, 8038.0, 8225.0, 8228.91771082289, 8238.835223295531, 8240.175982401772, 2237.999999999996, 2262.8189744820374, 2266.3767463947465, 2266.795988361047, 2269.7503274639776, 2200.273909609833, 2232.2075663139594, 2234.3967128875192, 2236.0608544411307, 2237.5524895021063, 2182.5416662500893, 2216.756156822756, 2217.1353172262748, 2218.3899427657443, 2230.130249202812, 2127.585120901425, 2170.8371872109656, 2174.152080688533, 2181.6509358502562, 2182.3998400439846, 2174.836887233464, 2177.9763511149895, 2181.0588576167224, 2181.727284089489, 2182.1380554680973, 8080.515169089815, 8159.0, 8189.549574773385, 8220.219079187467, 8435.029971553227, 4816.060868130716, 4946.480619534933, 4948.257761335793, 4950.950490495121, 4952.455229924705, 2993.745531629814, 3065.1877252528097, 3112.393083348748, 3122.032170027276, 3134.435801555719, 915.6566287642135, 930.3115694386173, 934.219926361489, 942.1285311087286, 942.990570094304, 11405.258658187191, 11533.250338727956, 11542.538298468051, 11551.653450396501, 11557.422128893522, 3954.7824869632445, 4105.958940410557, 4199.265128602482, 4211.389348544444, 4263.2752432086, 8919.777005574913, 8920.73237802867, 8963.372563920593, 8973.775655608531, 8973.820523589491, 4716.103940251342, 4719.174144524694, 4726.172919739032, 4735.976320118446, 4739.099571081483, 3570.839312230956, 4196.328587426058, 4369.60673539383, 4378.671599629977, 4425.668074894395, 3581.585273816828, 3583.2654305867236, 3679.0, 3687.1888184599347, 3732.6080761520193, 1072.8122578548723, 1086.3916206923989, 1091.8034753744403, 1094.9397783122006, 1101.498818037791, 565.6912546803113, 679.242644451443, 706.3078183380316, 742.840289337795, 808.2039191396469, 5127.717975511383, 5249.47505249472, 5267.446918073624, 5335.519803217729, 5413.83758487246, 883.3021912688904, 909.6370885654886, 944.6882528765491, 962.4802606592361, 979.4319294808994, 3360.9663903361143, 3536.1336472564385, 3563.7861728296384, 3564.144605294711, 3597.7661452005536, 10029.548670309854, 10365.118964888068, 10513.106385957126, 10539.104176145114, 10553.155747540179, 10240.0, 10300.587976481007, 10305.175585953106, 10312.896871031344, 10412.947935260427, 7332.926670733331, 7428.85142297151, 7453.664585093684, 7453.813654658677, 7487.064116985377, 5076.695398276115, 5339.973300133474, 5456.918146227889, 5474.781008759605, 5591.440855914539, 8970.955145224232, 9525.90474095278, 9540.045995400404, 9549.713508594754, 9560.61757529691, 9119.680811171576, 9499.525023748924, 9535.046495350409, 9733.02669733021, 9734.513274336114, 6026.216591843032, 6043.697815109315, 6233.625982441068, 6768.221654509597, 6917.9308206917285, 6594.967025164843, 7659.846803064019, 7691.88462173079, 7708.344790692854, 7715.498492597963, 6543.509236807164, 7046.436285097282, 7089.432845372255, 7204.3155900189395, 7317.5609463432365, 6982.546134501241, 7051.647417628996, 7086.433085353056, 7163.570185788869, 7223.638818059181, 5962.135490353788, 6330.8100756977365, 6380.330065343072, 6402.039694045744, 6416.037594360883, 4439.62263207631, 4463.843765468193, 4570.6800523963, 4599.67802253839, 4679.27471241958, 4484.75333856641, 4604.424446944132, 4673.813047478063, 4707.105649926503, 4714.38712967312], "value": 4207.901872983957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9488386974214, 302.83192827980474, 315.4369450530803, 315.715855729843, 316.7133743961714, 4945.258211268307, 4986.177280748681, 4999.275105109757, 5015.072211640844, 5021.146405111126, 4655.976720116403, 4746.90506189876, 4790.7125572465675, 4794.5205479452125, 4942.233953737167, 3712.3874560697454, 3716.609755975611, 3743.625637436262, 3865.9806700966456, 3874.1476875087437, 3870.013146647601, 3873.128546077124, 3887.0, 3901.08324543732, 3916.1971795781938, 3644.5808731995894, 3844.5578758442716, 3865.7100717446165, 3875.903102422448, 3887.581032922991, 3796.4115562087923, 3824.7513911595656, 3841.67345775608, 3844.192719528902, 3852.287326844543, 3328.151321413024, 3333.916652083693, 3357.2949680567112, 3358.22760765023, 3358.781679190869, 4801.831935882262, 4832.806687732486, 4848.321235027099, 4858.125537403266, 4870.51449307961, 4154.712039267836, 4319.546447622985, 4330.501992270898, 4370.497392799805, 4371.737695738266, 5103.183490641517, 5103.872403189913, 5121.443234091016, 5128.384593848725, 5158.767855446514, 3640.526731524911, 3642.1258897864586, 3661.2677464507206, 3678.2459595782802, 3681.4661874028384, 5190.8183213587345, 5344.278522399465, 5394.811181608664, 5418.539424148952, 5444.7822087116465, 3699.2231631357718, 3712.9071773205346, 3724.2365315110337, 3729.776213427149, 3755.248950209969, 3771.717121215865, 3777.206786574795, 3777.206786574795, 3793.829277682511, 3799.2781371539318, 4315.741055536678, 4339.786708778545, 4346.543612920661, 4347.913041739147, 4357.586029327209, 4869.22092465211, 5101.693898366036, 5134.974325128351, 5144.948550514522, 5170.3278573785165, 1195.9581414650445, 1292.7479141567492, 1306.399056434032, 1309.6791286134958, 1311.6524121107914, 858.2361698088706, 893.6246776353947, 895.6283142495791, 896.9775755606162, 904.9185573298435, 4510.932336014962, 4513.593776560126, 4533.591976722111, 4541.364209010741, 4549.499555048942, 5314.335708036496, 5318.0, 5319.494648008433, 5319.893602127936, 5320.457067450473, 4407.316865885793, 4463.152001119777, 4475.232283248099, 4516.932246016312, 4543.363929049936, 2783.540715781873, 2794.902178423745, 2809.2415047936943, 2819.1401622504923, 2822.618946442204, 4972.751362431936, 4974.37820272466, 4975.427825800007, 4978.327925730053, 5004.649674522821, 5250.0, 5380.488853558905, 5391.35303763543, 5395.676259424447, 5410.377806552218, 4888.462269150391, 4906.803727850846, 4939.653664509401, 4954.628402869799, 4997.925031124463, 5039.521245481674, 5265.473452654704, 5269.78920843162, 5323.787048518016, 5325.041492531382, 5117.872053198551, 5119.0, 5143.202803565453, 5153.613478989016, 5178.249153872592, 4884.462709101925, 4910.484399138182, 4927.482614325444, 4981.704756763195, 5000.199968005102, 3712.5173727415263, 3728.6457786510236, 3730.9440358394104, 3734.3651579231055, 3738.3457894867747, 5030.220315851049, 5341.359036915595, 5348.893022139458, 5353.571714262772, 5362.65142765719, 5163.845084647466, 5175.870603234949, 5176.818811341585, 5179.378474583074, 5216.5393689766925, 5112.514311140436, 5169.144398600507, 5214.539928819937, 5257.579393648422, 5268.394134674561, 4855.465898751064, 4966.751662416792, 5094.949050509447, 5101.540861322499, 5110.131277682728, 5234.1102012657175, 5259.579233661374, 5262.657927234717, 5271.077561426811, 5274.208868669731, 5149.201873709581, 5149.9742501287255, 5152.407473140487, 5154.020736060136, 5154.5103215194495], "value": 3877.6277929608173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.425887995204, 675.8344205669608, 695.4992405468062, 706.5442789400837, 732.2348146187232, 12135.817962730554, 13290.136141150842, 13296.933515332434, 13315.400806963686, 13322.40049197786, 12617.621471355875, 12905.1611645243, 13007.349632518384, 13027.218366897992, 13038.0, 793.7063286583972, 799.9720009799659, 804.5293503300576, 806.6773290683744, 807.5235610989515, 628.9308176100625, 766.9309762121408, 792.3621484704811, 795.3796039089519, 797.2306724011328, 832.4505826154739, 834.6869923778584, 836.8577341851869, 837.7696133563257, 838.5429940682312, 645.5416654175494, 825.6119623776815, 827.3711978896052, 827.6772058897066, 827.9710210142646, 578.7511370110851, 594.7650677982173, 595.074658905402, 595.642614431342, 599.2479438304943, 13009.414576343992, 13067.803982940264, 13515.189088654712, 13538.729225415436, 13556.254406007665, 12822.0, 13215.33923303831, 13304.20174789506, 13365.198088114745, 13535.32323383827, 11863.644090677208, 11905.940470297593, 11915.404229788475, 11959.820602690967, 12477.50089996399, 4228.539173404765, 4237.55891045612, 4254.127903779718, 4278.208531421666, 4303.978480107611, 58487.415125849046, 58925.70537147287, 58945.705271473365, 58972.41027589712, 59089.40910590925, 8398.538080405515, 8604.5697715114, 8631.180037896389, 8656.0, 8673.349498787617, 16837.494875153767, 16847.663046738995, 16848.74726879098, 18320.358787442376, 18736.063196840376, 7220.819479513054, 7338.4496162788, 7626.23737626244, 7660.425468089916, 7688.231176882379, 3751.2122454284904, 3874.283257597297, 3919.000654833056, 3921.8235179416993, 3936.173403585279, 2945.4403663304333, 3045.680203578637, 3046.817190968549, 3051.4354844353866, 3057.357954829466, 513.335230876009, 520.4171328112539, 523.6203752279566, 523.7512181713655, 567.0983136812488, 519.2030233591419, 522.339240860312, 528.5744975294848, 537.9220013098079, 566.3006187358609, 8214.342852571779, 8564.78942066993, 8658.826823463496, 8885.733427997171, 8910.331725120643, 473.3562355196929, 482.76344591150786, 510.57877251267854, 537.7885423360175, 546.4098773324799, 3847.8653247136217, 4016.7389119707127, 4247.6389506892265, 4274.465691788527, 4275.508316543575, 103478.48260758798, 104534.47732761287, 104620.47689761502, 105303.0, 107329.0, 89649.0, 90713.54643226742, 91132.0, 92844.53577732068, 93057.0, 78258.6087069561, 78764.0, 79049.20950790534, 79902.20097799064, 80454.0, 7935.84128317442, 8066.959665201636, 8180.222878826502, 8201.13888041747, 8315.792105197177, 47888.521114788404, 48486.5151348482, 49478.0, 49820.750896245285, 50379.49620503748, 47389.104435822184, 54039.18941215806, 59746.701266493386, 61190.69404652948, 70836.0, 12566.84224729894, 12804.807927880904, 12840.229586224856, 12955.222686638832, 13351.132176408502, 12158.270503769802, 13008.349582521025, 13088.411021503865, 13320.33398330099, 13607.319634018457, 11696.855987287156, 11756.059515238589, 12074.698132546757, 12288.324142172267, 12432.191907526343, 11872.940635296769, 11877.524899003944, 12031.0, 12054.15620906528, 12381.504739810307, 12314.261144331369, 12508.812367814307, 12641.0, 12657.746845063231, 12666.683332916382, 8968.0, 9178.449293042439, 9326.72019839406, 9406.717798466058, 9434.95282523583, 10256.538455769658, 10520.842187367349, 10595.735106622396, 10684.09185219265, 10707.839382409114], "value": 6702.474668163933, "unit": "score"}], "name": "dromaeo_css", "value": 6563.671359413215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 117.0, 115.0, 116.0, 115.0, 114.0, 117.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 123.0, 175.0, 123.0, 129.0, 156.0, 121.0, 193.0, 124.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 169.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 105.0, 76.0, 77.0, 74.0, 76.0, 100.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 129.0, 84.0, 85.0, 85.0, 130.0, 85.0, 93.0, 120.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 145.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 61.0, 63.0, 63.0, 61.0, 61.0, 61.0, 61.0, 65.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 85.0, 81.0, 84.0, 79.0, 81.0, 83.0, 79.0, 85.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 135.0, 131.0, 131.0, 150.0, 131.0, 127.0, 172.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 163.0, 163.0, 163.0, 164.0, 163.0, 165.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1531.8999999999999, "alertThreshold": 2.0}]} 00:43:48 INFO - Return code: 0 00:43:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:48 INFO - # TBPL SUCCESS # 00:43:48 INFO - Running post-action listener: _resource_record_post_action 00:43:48 INFO - ##### 00:43:48 INFO - ##### Finished run-tests step (success) 00:43:48 INFO - ##### 00:43:48 INFO - Running post-run listener: _resource_record_post_run 00:43:48 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535994368; Read time: 16; Write time: 378968 00:43:48 INFO - TinderboxPrint: CPU usage
13.0% 00:43:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:43:48 INFO - TinderboxPrint: I/O write bytes / time
535,994,368 / 378,968 00:43:48 INFO - TinderboxPrint: CPU idle
8,335.8 (87.0%) 00:43:48 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 00:43:48 INFO - TinderboxPrint: Swap in / out
0 / 0 00:43:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247140352; Read time: 0; Write time: 215124 00:43:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288854016; Read time: 0; Write time: 163844 00:43:49 INFO - Running post-run listener: _upload_blobber_files 00:43:49 INFO - Blob upload gear active. 00:43:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:49 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 00:43:49 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'] 00:43:49 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 00:43:49 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:50 INFO - (blobuploader) - INFO - Done attempting. 00:43:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:43:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:53 INFO - (blobuploader) - INFO - Done attempting. 00:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:43:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:54 INFO - (blobuploader) - INFO - Done attempting. 00:43:54 INFO - (blobuploader) - INFO - Iteration through files over. 00:43:54 INFO - Return code: 0 00:43:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:43:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:43:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ae15f939b74c11df07d22aea276229a8fb0a92a0a2af3e0bfda0b0bedfd8094c2fa84b997198cc3a330af8197e70e845a49393c42f5fdd1b03d83c1aab02fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2e33fc4b72c382a95742ff4a263b3e7b3868cbc57e84794f94adc133d021a0e651ee31e4cb7aeb24df98fcd41f94d3a420f1b93bc978707c94da90f88c3d94f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae6deba1a920c654bc18805ced3cbb938a4cc4c387f0a5a1f4e9feaf5ac320834ba8eb0aa4633de43dc2938bb11d758054999f3235519c5463736ce832737e01"} 00:43:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:43:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:43:54 INFO - Contents: 00:43:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ae15f939b74c11df07d22aea276229a8fb0a92a0a2af3e0bfda0b0bedfd8094c2fa84b997198cc3a330af8197e70e845a49393c42f5fdd1b03d83c1aab02fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2e33fc4b72c382a95742ff4a263b3e7b3868cbc57e84794f94adc133d021a0e651ee31e4cb7aeb24df98fcd41f94d3a420f1b93bc978707c94da90f88c3d94f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae6deba1a920c654bc18805ced3cbb938a4cc4c387f0a5a1f4e9feaf5ac320834ba8eb0aa4633de43dc2938bb11d758054999f3235519c5463736ce832737e01"} 00:43:54 INFO - Running post-run listener: copy_logs_to_upload_dir 00:43:54 INFO - Copying logs to upload dir... 00:43:54 INFO - mkdir: /builds/slave/test/build/upload/logs 00:43:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.184996 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-16 00:43:53.873373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 00:43:53.876860) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 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/1ae15f939b74c11df07d22aea276229a8fb0a92a0a2af3e0bfda0b0bedfd8094c2fa84b997198cc3a330af8197e70e845a49393c42f5fdd1b03d83c1aab02fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2e33fc4b72c382a95742ff4a263b3e7b3868cbc57e84794f94adc133d021a0e651ee31e4cb7aeb24df98fcd41f94d3a420f1b93bc978707c94da90f88c3d94f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae6deba1a920c654bc18805ced3cbb938a4cc4c387f0a5a1f4e9feaf5ac320834ba8eb0aa4633de43dc2938bb11d758054999f3235519c5463736ce832737e01"} build_url:https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/Yyu785fjSi6bplgT7O2a-Q/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/1ae15f939b74c11df07d22aea276229a8fb0a92a0a2af3e0bfda0b0bedfd8094c2fa84b997198cc3a330af8197e70e845a49393c42f5fdd1b03d83c1aab02fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2e33fc4b72c382a95742ff4a263b3e7b3868cbc57e84794f94adc133d021a0e651ee31e4cb7aeb24df98fcd41f94d3a420f1b93bc978707c94da90f88c3d94f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae6deba1a920c654bc18805ced3cbb938a4cc4c387f0a5a1f4e9feaf5ac320834ba8eb0aa4633de43dc2938bb11d758054999f3235519c5463736ce832737e01"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 00:43:53.902276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:43:53.902632) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468653618.491079-1877737589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 00:43:53.985231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 00:43:53.985567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 00:43:53.985866) ========= ========= Total master_lag: 0.16 =========