builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1474134010.08 results: success (0) buildid: 20160917074612 builduid: df29e5a38e004f6187751299d9574f9e revision: f2fe5345c13ff5ec70dc259d653298a7cac61423 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.082301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.082729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.083001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.098353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.098753) ========= 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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 10:40:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-09-17 10:40:10 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.218143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.218453) ========= 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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023128 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:10.267704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 10:40:10.268051) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f2fe5345c13ff5ec70dc259d653298a7cac61423 --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 f2fe5345c13ff5ec70dc259d653298a7cac61423 --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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 10:40:10,980 truncating revision to first 12 chars 2016-09-17 10:40:10,980 Setting DEBUG logging. 2016-09-17 10:40:10,980 attempt 1/10 2016-09-17 10:40:10,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f2fe5345c13f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 10:40:11,777 unpacking tar archive at: fx-team-f2fe5345c13f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.119271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 10:40:11.400832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:11.401148) ========= script_repo_revision: f2fe5345c13ff5ec70dc259d653298a7cac61423 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:11.401551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:11.401828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 10:40:11.412255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-17 10:40:11.412540) ========= /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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:40:12 INFO - MultiFileLogger online at 20160917 10:40:12 in /builds/slave/test 10:40:12 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 10:40:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:40:12 INFO - {'append_to_log': False, 10:40:12 INFO - 'base_work_dir': '/builds/slave/test', 10:40:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:40:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:40:12 INFO - 'branch': 'Fx-Team-Non-PGO', 10:40:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:40:12 INFO - 'config_files': ('talos/linux_config.py',), 10:40:12 INFO - 'default_actions': ('clobber', 10:40:12 INFO - 'read-buildbot-config', 10:40:12 INFO - 'download-and-extract', 10:40:12 INFO - 'populate-webroot', 10:40:12 INFO - 'create-virtualenv', 10:40:12 INFO - 'install', 10:40:12 INFO - 'run-tests'), 10:40:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:40:12 INFO - 'download_minidump_stackwalk': True, 10:40:12 INFO - 'download_symbols': 'ondemand', 10:40:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:40:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:40:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:40:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:40:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:40:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:40:12 INFO - 'installer_path': 'installer.exe', 10:40:12 INFO - 'log_level': 'info', 10:40:12 INFO - 'log_name': 'talos', 10:40:12 INFO - 'log_to_console': True, 10:40:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:40:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:40:12 INFO - 'opt_config_files': (), 10:40:12 INFO - 'pip_index': False, 10:40:12 INFO - 'sps_profile': False, 10:40:12 INFO - 'sps_profile_interval': 0, 10:40:12 INFO - 'suite': 'dromaeojs', 10:40:12 INFO - 'system_bits': '32', 10:40:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:40:12 INFO - 'title': 'talos-linux64-ix-001', 10:40:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:40:12 INFO - 'use_talos_json': True, 10:40:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:40:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:40:12 INFO - 'work_dir': 'build'} 10:40:12 INFO - [mozharness: 2016-09-17 17:40:12.213274Z] Running clobber step. 10:40:12 INFO - Running pre-action listener: _resource_record_pre_action 10:40:12 INFO - Running main action method: clobber 10:40:12 INFO - rmtree: /builds/slave/test/build 10:40:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:40:12 INFO - Running post-action listener: _resource_record_post_action 10:40:12 INFO - [mozharness: 2016-09-17 17:40:12.671387Z] Finished clobber step (success) 10:40:12 INFO - [mozharness: 2016-09-17 17:40:12.671487Z] Running read-buildbot-config step. 10:40:12 INFO - Running pre-action listener: _resource_record_pre_action 10:40:12 INFO - Running main action method: read_buildbot_config 10:40:12 INFO - Using buildbot properties: 10:40:12 INFO - { 10:40:12 INFO - "project": "", 10:40:12 INFO - "product": "firefox", 10:40:12 INFO - "script_repo_revision": "production", 10:40:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:40:12 INFO - "repository": "", 10:40:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:40:12 INFO - "buildid": "20160917074612", 10:40:12 INFO - "stage_platform": "linux64", 10:40:12 INFO - "basedir": "/builds/slave/test", 10:40:12 INFO - "buildnumber": 1938, 10:40:12 INFO - "platform": "ubuntu64_hw", 10:40:12 INFO - "mozci_request": { 10:40:12 INFO - "priority": -1, 10:40:12 INFO - "type": "trigger_all_talos_jobs", 10:40:12 INFO - "times": 6 10:40:12 INFO - }, 10:40:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:40:12 INFO - "slavebuilddir": "test", 10:40:12 INFO - "branch": "fx-team", 10:40:12 INFO - "revision": "f2fe5345c13ff5ec70dc259d653298a7cac61423", 10:40:12 INFO - "slavename": "talos-linux64-ix-001", 10:40:12 INFO - "builduid": "df29e5a38e004f6187751299d9574f9e", 10:40:12 INFO - "repo_path": "integration/fx-team" 10:40:12 INFO - } 10:40:12 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:40:12 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 10:40:12 INFO - Running post-action listener: _resource_record_post_action 10:40:12 INFO - [mozharness: 2016-09-17 17:40:12.674235Z] Finished read-buildbot-config step (success) 10:40:12 INFO - [mozharness: 2016-09-17 17:40:12.674323Z] Running download-and-extract step. 10:40:12 INFO - Running pre-action listener: _resource_record_pre_action 10:40:12 INFO - Running main action method: download_and_extract 10:40:12 INFO - mkdir: /builds/slave/test/build/tests 10:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:40:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:40:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:40:12 INFO - Downloaded 1361 bytes. 10:40:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:40:12 INFO - Using the following test package requirements: 10:40:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:40:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:40:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'jsshell-linux-x86_64.zip'], 10:40:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:40:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:40:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:40:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:40:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:40:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:40:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:40:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:40:12 INFO - Expected file size: 20365791 10:40:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:40:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:40:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:17 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:40:17 INFO - Expected file size: 20365791 10:40:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:40:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:40:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:40:21 INFO - Expected file size: 14414048 10:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:22 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:40:22 INFO - Downloaded 55593420 bytes. 10:40:22 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - mkdir: /builds/slave/test/properties 10:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:40:22 INFO - Writing to file /builds/slave/test/properties/build_url 10:40:22 INFO - Contents: 10:40:22 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:40:23 INFO - Running post-action listener: _resource_record_post_action 10:40:23 INFO - Running post-action listener: set_extra_try_arguments 10:40:23 INFO - [mozharness: 2016-09-17 17:40:23.150619Z] Finished download-and-extract step (success) 10:40:23 INFO - [mozharness: 2016-09-17 17:40:23.150850Z] Running populate-webroot step. 10:40:23 INFO - Running pre-action listener: _resource_record_pre_action 10:40:23 INFO - Running main action method: populate_webroot 10:40:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:40:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:40:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:40:23 INFO - '--tppagecycles', 10:40:23 INFO - '7'], 10:40:23 INFO - 'tests': ['tsvgm']}}, 10:40:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:40:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:40:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:40:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:40:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['damp', 'tps']}, 10:40:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'tests': ['damp', 'tps']}, 10:40:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['dromaeo_dom']}, 10:40:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:40:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['basic_compositor_video']}, 10:40:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:40:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'other-e10s': {'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['a11yr', 10:40:23 INFO - 'ts_paint', 10:40:23 INFO - 'tpaint', 10:40:23 INFO - 'sessionrestore', 10:40:23 INFO - 'sessionrestore_no_auto_restore', 10:40:23 INFO - 'tabpaint']}, 10:40:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['tsvgx', 10:40:23 INFO - 'tsvgr_opacity', 10:40:23 INFO - 'tart', 10:40:23 INFO - 'tscrollx', 10:40:23 INFO - 'cart']}, 10:40:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:40:23 INFO - 'tsvgr_opacity', 10:40:23 INFO - 'tart', 10:40:23 INFO - 'tscrollx', 10:40:23 INFO - 'cart']}, 10:40:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'talos_options': ['--disable-e10s'], 10:40:23 INFO - 'tests': ['tp5o']}, 10:40:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'tests': ['tp5o']}, 10:40:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'talos_options': ['--disable-e10s', 10:40:23 INFO - '--xperf_path', 10:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:23 INFO - 'tests': ['tp5n']}, 10:40:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:23 INFO - 'talos_options': ['--xperf_path', 10:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:23 INFO - 'tests': ['tp5n']}}, 10:40:23 INFO - 'talos.zip': {'path': '', 10:40:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:40:23 INFO - Running post-action listener: _resource_record_post_action 10:40:23 INFO - [mozharness: 2016-09-17 17:40:23.166620Z] Finished populate-webroot step (success) 10:40:23 INFO - [mozharness: 2016-09-17 17:40:23.166709Z] Running create-virtualenv step. 10:40:23 INFO - Running pre-action listener: _resource_record_pre_action 10:40:23 INFO - Running main action method: create_virtualenv 10:40:23 INFO - Creating virtualenv /builds/slave/test/build/venv 10:40:23 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 10:40:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:40:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:40:23 INFO - Using real prefix '/usr' 10:40:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:40:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:40:25 INFO - Installing pip.................done. 10:40:25 INFO - Return code: 0 10:40:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:40:25 INFO - Using env: {'DISPLAY': ':0', 10:40:25 INFO - 'HOME': '/home/cltbld', 10:40:25 INFO - 'LANG': 'en_US.UTF-8', 10:40:25 INFO - 'LANGUAGE': 'en_US:en', 10:40:25 INFO - 'LOGNAME': 'cltbld', 10:40:25 INFO - 'MAIL': '/var/mail/cltbld', 10:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:25 INFO - 'MOZ_NO_REMOTE': '1', 10:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:25 INFO - 'NO_EM_RESTART': '1', 10:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:25 INFO - 'PWD': '/builds/slave/test', 10:40:25 INFO - 'SHELL': '/bin/bash', 10:40:25 INFO - 'SHLVL': '1', 10:40:25 INFO - 'TERM': 'linux', 10:40:25 INFO - 'TMOUT': '86400', 10:40:25 INFO - 'USER': 'cltbld', 10:40:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:25 INFO - '_': '/tools/buildbot/bin/python'} 10:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:25 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 10:40:25 INFO - Cleaning up... 10:40:25 INFO - Return code: 0 10:40:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:40:25 INFO - Using env: {'DISPLAY': ':0', 10:40:25 INFO - 'HOME': '/home/cltbld', 10:40:25 INFO - 'LANG': 'en_US.UTF-8', 10:40:25 INFO - 'LANGUAGE': 'en_US:en', 10:40:25 INFO - 'LOGNAME': 'cltbld', 10:40:25 INFO - 'MAIL': '/var/mail/cltbld', 10:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:25 INFO - 'MOZ_NO_REMOTE': '1', 10:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:25 INFO - 'NO_EM_RESTART': '1', 10:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:25 INFO - 'PWD': '/builds/slave/test', 10:40:25 INFO - 'SHELL': '/bin/bash', 10:40:25 INFO - 'SHLVL': '1', 10:40:25 INFO - 'TERM': 'linux', 10:40:25 INFO - 'TMOUT': '86400', 10:40:25 INFO - 'USER': 'cltbld', 10:40:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:25 INFO - '_': '/tools/buildbot/bin/python'} 10:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:26 INFO - Downloading/unpacking psutil>=3.1.1 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:28 INFO - Installing collected packages: psutil 10:40:28 INFO - Running setup.py install for psutil 10:40:28 INFO - building 'psutil._psutil_linux' extension 10:40:28 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 10:40:28 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 10:40:28 INFO - building 'psutil._psutil_posix' extension 10:40:28 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 10:40:28 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 10:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:28 INFO - Successfully installed psutil 10:40:28 INFO - Cleaning up... 10:40:28 INFO - Return code: 0 10:40:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:40: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 mozsystemmonitor==0.3 10:40:28 INFO - Using env: {'DISPLAY': ':0', 10:40:28 INFO - 'HOME': '/home/cltbld', 10:40:28 INFO - 'LANG': 'en_US.UTF-8', 10:40:28 INFO - 'LANGUAGE': 'en_US:en', 10:40:28 INFO - 'LOGNAME': 'cltbld', 10:40:28 INFO - 'MAIL': '/var/mail/cltbld', 10:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:28 INFO - 'MOZ_NO_REMOTE': '1', 10:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:28 INFO - 'NO_EM_RESTART': '1', 10:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:28 INFO - 'PWD': '/builds/slave/test', 10:40:28 INFO - 'SHELL': '/bin/bash', 10:40:28 INFO - 'SHLVL': '1', 10:40:28 INFO - 'TERM': 'linux', 10:40:28 INFO - 'TMOUT': '86400', 10:40:28 INFO - 'USER': 'cltbld', 10:40:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:28 INFO - '_': '/tools/buildbot/bin/python'} 10:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:40:30 INFO - Installing collected packages: mozsystemmonitor 10:40:30 INFO - Running setup.py install for mozsystemmonitor 10:40:30 INFO - Successfully installed mozsystemmonitor 10:40:30 INFO - Cleaning up... 10:40:31 INFO - Return code: 0 10:40:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:40:31 INFO - Using env: {'DISPLAY': ':0', 10:40:31 INFO - 'HOME': '/home/cltbld', 10:40:31 INFO - 'LANG': 'en_US.UTF-8', 10:40:31 INFO - 'LANGUAGE': 'en_US:en', 10:40:31 INFO - 'LOGNAME': 'cltbld', 10:40:31 INFO - 'MAIL': '/var/mail/cltbld', 10:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:31 INFO - 'MOZ_NO_REMOTE': '1', 10:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:31 INFO - 'NO_EM_RESTART': '1', 10:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:31 INFO - 'PWD': '/builds/slave/test', 10:40:31 INFO - 'SHELL': '/bin/bash', 10:40:31 INFO - 'SHLVL': '1', 10:40:31 INFO - 'TERM': 'linux', 10:40:31 INFO - 'TMOUT': '86400', 10:40:31 INFO - 'USER': 'cltbld', 10:40:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:31 INFO - '_': '/tools/buildbot/bin/python'} 10:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:40:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:40:33 INFO - warning: no files found matching '*.txt' 10:40:33 INFO - no previously-included directories found matching 'build' 10:40:33 INFO - no previously-included directories found matching 'dist' 10:40:33 INFO - no previously-included directories found matching '.git*' 10:40:33 INFO - Installing collected packages: jsonschema, functools32 10:40:33 INFO - Running setup.py install for functools32 10:40:33 INFO - warning: no files found matching '*.txt' 10:40:33 INFO - no previously-included directories found matching 'build' 10:40:33 INFO - no previously-included directories found matching 'dist' 10:40:33 INFO - no previously-included directories found matching '.git*' 10:40:33 INFO - Successfully installed jsonschema functools32 10:40:33 INFO - Cleaning up... 10:40:33 INFO - Return code: 0 10:40:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:40: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 functools32==3.2.3-2 10:40:33 INFO - Using env: {'DISPLAY': ':0', 10:40:33 INFO - 'HOME': '/home/cltbld', 10:40:33 INFO - 'LANG': 'en_US.UTF-8', 10:40:33 INFO - 'LANGUAGE': 'en_US:en', 10:40:33 INFO - 'LOGNAME': 'cltbld', 10:40:33 INFO - 'MAIL': '/var/mail/cltbld', 10:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:33 INFO - 'MOZ_NO_REMOTE': '1', 10:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:33 INFO - 'NO_EM_RESTART': '1', 10:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:33 INFO - 'PWD': '/builds/slave/test', 10:40:33 INFO - 'SHELL': '/bin/bash', 10:40:33 INFO - 'SHLVL': '1', 10:40:33 INFO - 'TERM': 'linux', 10:40:33 INFO - 'TMOUT': '86400', 10:40:33 INFO - 'USER': 'cltbld', 10:40:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:33 INFO - '_': '/tools/buildbot/bin/python'} 10:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:40:33 INFO - Cleaning up... 10:40:33 INFO - Return code: 0 10:40:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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', '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 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:40: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 blobuploader==1.2.4 10:40:33 INFO - Using env: {'DISPLAY': ':0', 10:40:33 INFO - 'HOME': '/home/cltbld', 10:40:33 INFO - 'LANG': 'en_US.UTF-8', 10:40:33 INFO - 'LANGUAGE': 'en_US:en', 10:40:33 INFO - 'LOGNAME': 'cltbld', 10:40:33 INFO - 'MAIL': '/var/mail/cltbld', 10:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:33 INFO - 'MOZ_NO_REMOTE': '1', 10:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:33 INFO - 'NO_EM_RESTART': '1', 10:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:33 INFO - 'PWD': '/builds/slave/test', 10:40:33 INFO - 'SHELL': '/bin/bash', 10:40:33 INFO - 'SHLVL': '1', 10:40:33 INFO - 'TERM': 'linux', 10:40:33 INFO - 'TMOUT': '86400', 10:40:33 INFO - 'USER': 'cltbld', 10:40:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:33 INFO - '_': '/tools/buildbot/bin/python'} 10:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:40:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:40:35 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 10:40:35 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 10:40:35 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 10:40:35 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 10:40:35 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 10:40:35 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 10:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:40:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:36 INFO - Downloading docopt-0.6.1.tar.gz 10:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:40:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:40:36 INFO - Running setup.py install for blobuploader 10:40:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:40:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:40:36 INFO - Running setup.py install for requests 10:40:37 INFO - Running setup.py install for docopt 10:40:37 INFO - Successfully installed blobuploader requests docopt 10:40:37 INFO - Cleaning up... 10:40:37 INFO - Return code: 0 10:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:40:37 INFO - Using env: {'DISPLAY': ':0', 10:40:37 INFO - 'HOME': '/home/cltbld', 10:40:37 INFO - 'LANG': 'en_US.UTF-8', 10:40:37 INFO - 'LANGUAGE': 'en_US:en', 10:40:37 INFO - 'LOGNAME': 'cltbld', 10:40:37 INFO - 'MAIL': '/var/mail/cltbld', 10:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:37 INFO - 'MOZ_NO_REMOTE': '1', 10:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:37 INFO - 'NO_EM_RESTART': '1', 10:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:37 INFO - 'PWD': '/builds/slave/test', 10:40:37 INFO - 'SHELL': '/bin/bash', 10:40:37 INFO - 'SHLVL': '1', 10:40:37 INFO - 'TERM': 'linux', 10:40:37 INFO - 'TMOUT': '86400', 10:40:37 INFO - 'USER': 'cltbld', 10:40:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:37 INFO - '_': '/tools/buildbot/bin/python'} 10:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:37 INFO - Running setup.py (path:/tmp/pip-QXrUf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:37 INFO - Running setup.py (path:/tmp/pip-rYyUYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:37 INFO - Running setup.py (path:/tmp/pip-_4P2kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:37 INFO - Running setup.py (path:/tmp/pip-oMrRz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:37 INFO - Running setup.py (path:/tmp/pip-L8UEri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:37 INFO - Running setup.py (path:/tmp/pip-D6vCIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:37 INFO - Running setup.py (path:/tmp/pip-knpcGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:37 INFO - Running setup.py (path:/tmp/pip-cJMAHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:38 INFO - Running setup.py (path:/tmp/pip-5zwzHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:38 INFO - Running setup.py (path:/tmp/pip-Ci_COZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:38 INFO - Running setup.py (path:/tmp/pip-YxRiC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:38 INFO - Running setup.py (path:/tmp/pip-cqKAyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:38 INFO - Running setup.py (path:/tmp/pip-XR6jb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:38 INFO - Running setup.py (path:/tmp/pip-Mm9RJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:38 INFO - Running setup.py (path:/tmp/pip-aePUDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:38 INFO - Running setup.py (path:/tmp/pip-QHWbrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:38 INFO - Running setup.py (path:/tmp/pip-FrOPjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:40:38 INFO - Running setup.py install for manifestparser 10:40:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:40:38 INFO - Running setup.py install for mozcrash 10:40:38 INFO - Running setup.py install for mozdebug 10:40:39 INFO - Running setup.py install for mozdevice 10:40:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for mozfile 10:40:39 INFO - Running setup.py install for mozhttpd 10:40:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for mozinfo 10:40:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for mozInstall 10:40:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for mozleak 10:40:39 INFO - Running setup.py install for mozlog 10:40:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for moznetwork 10:40:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:40:39 INFO - Running setup.py install for mozprocess 10:40:39 INFO - Running setup.py install for mozprofile 10:40:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:40:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:40:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:40:40 INFO - Running setup.py install for mozrunner 10:40:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:40:40 INFO - Running setup.py install for mozscreenshot 10:40:40 INFO - Running setup.py install for moztest 10:40:40 INFO - Running setup.py install for mozversion 10:40:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:40:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:40:40 INFO - Cleaning up... 10:40:40 INFO - Return code: 0 10:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:40 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 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:40 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 10:40:40 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 10:40:40 INFO - Using env: {'DISPLAY': ':0', 10:40:40 INFO - 'HOME': '/home/cltbld', 10:40:40 INFO - 'LANG': 'en_US.UTF-8', 10:40:40 INFO - 'LANGUAGE': 'en_US:en', 10:40:40 INFO - 'LOGNAME': 'cltbld', 10:40:40 INFO - 'MAIL': '/var/mail/cltbld', 10:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:40 INFO - 'MOZ_NO_REMOTE': '1', 10:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:40 INFO - 'NO_EM_RESTART': '1', 10:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:40 INFO - 'PWD': '/builds/slave/test', 10:40:40 INFO - 'SHELL': '/bin/bash', 10:40:40 INFO - 'SHLVL': '1', 10:40:40 INFO - 'TERM': 'linux', 10:40:40 INFO - 'TMOUT': '86400', 10:40:40 INFO - 'USER': 'cltbld', 10:40:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:40 INFO - '_': '/tools/buildbot/bin/python'} 10:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:40 INFO - Running setup.py (path:/tmp/pip-chExpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:40 INFO - Running setup.py (path:/tmp/pip-mRqWIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:40 INFO - Running setup.py (path:/tmp/pip-cMtAQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:40 INFO - Running setup.py (path:/tmp/pip-4Yun8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:41 INFO - Running setup.py (path:/tmp/pip-6B7cNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:41 INFO - Running setup.py (path:/tmp/pip-s8dUJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:41 INFO - Running setup.py (path:/tmp/pip-6LleSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:41 INFO - Running setup.py (path:/tmp/pip-8V8mfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:41 INFO - Running setup.py (path:/tmp/pip-gMoyUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:41 INFO - Running setup.py (path:/tmp/pip-VZOcEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:41 INFO - Running setup.py (path:/tmp/pip-_asGXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:41 INFO - Running setup.py (path:/tmp/pip-5SFEqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:41 INFO - Running setup.py (path:/tmp/pip-Fmh2Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:41 INFO - Running setup.py (path:/tmp/pip-wvwkDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:41 INFO - Running setup.py (path:/tmp/pip-uoWLH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:41 INFO - Running setup.py (path:/tmp/pip-aENYcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:41 INFO - Running setup.py (path:/tmp/pip-l6mTkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:43 INFO - Downloading blessings-1.6.tar.gz 10:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:40:43 INFO - Installing collected packages: blessings 10:40:43 INFO - Running setup.py install for blessings 10:40:44 INFO - Successfully installed blessings 10:40:44 INFO - Cleaning up... 10:40:44 INFO - Return code: 0 10:40:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:44 INFO - Reading from file tmpfile_stdout 10:40:44 INFO - Current package versions: 10:40:44 INFO - argparse == 1.2.1 10:40:44 INFO - blessings == 1.6 10:40:44 INFO - blobuploader == 1.2.4 10:40:44 INFO - docopt == 0.6.1 10:40:44 INFO - functools32 == 3.2.3-2 10:40:44 INFO - jsonschema == 2.5.1 10:40:44 INFO - manifestparser == 1.1 10:40:44 INFO - mozInstall == 1.12 10:40:44 INFO - mozcrash == 0.17 10:40:44 INFO - mozdebug == 0.1 10:40:44 INFO - mozdevice == 0.48 10:40:44 INFO - mozfile == 1.2 10:40:44 INFO - mozhttpd == 0.7 10:40:44 INFO - mozinfo == 0.9 10:40:44 INFO - mozleak == 0.1 10:40:44 INFO - mozlog == 3.4 10:40:44 INFO - moznetwork == 0.27 10:40:44 INFO - mozprocess == 0.23 10:40:44 INFO - mozprofile == 0.28 10:40:44 INFO - mozrunner == 6.12 10:40:44 INFO - mozscreenshot == 0.1 10:40:44 INFO - mozsystemmonitor == 0.3 10:40:44 INFO - moztest == 0.7 10:40:44 INFO - mozversion == 1.4 10:40:44 INFO - psutil == 3.1.1 10:40:44 INFO - requests == 1.2.3 10:40:44 INFO - wsgiref == 0.1.2 10:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:44 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 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:44 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 10:40:44 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 10:40:44 INFO - Using env: {'DISPLAY': ':0', 10:40:44 INFO - 'HOME': '/home/cltbld', 10:40:44 INFO - 'LANG': 'en_US.UTF-8', 10:40:44 INFO - 'LANGUAGE': 'en_US:en', 10:40:44 INFO - 'LOGNAME': 'cltbld', 10:40:44 INFO - 'MAIL': '/var/mail/cltbld', 10:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:44 INFO - 'MOZ_NO_REMOTE': '1', 10:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:44 INFO - 'NO_EM_RESTART': '1', 10:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:44 INFO - 'PWD': '/builds/slave/test', 10:40:44 INFO - 'SHELL': '/bin/bash', 10:40:44 INFO - 'SHLVL': '1', 10:40:44 INFO - 'TERM': 'linux', 10:40:44 INFO - 'TMOUT': '86400', 10:40:44 INFO - 'USER': 'cltbld', 10:40:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:44 INFO - '_': '/tools/buildbot/bin/python'} 10:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 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)) 10:40:44 INFO - Cleaning up... 10:40:44 INFO - Return code: 0 10:40:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:44 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 0x7f838743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', '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 10:40:44 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 10:40:44 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 10:40:44 INFO - Using env: {'DISPLAY': ':0', 10:40:44 INFO - 'HOME': '/home/cltbld', 10:40:44 INFO - 'LANG': 'en_US.UTF-8', 10:40:44 INFO - 'LANGUAGE': 'en_US:en', 10:40:44 INFO - 'LOGNAME': 'cltbld', 10:40:44 INFO - 'MAIL': '/var/mail/cltbld', 10:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:44 INFO - 'MOZ_NO_REMOTE': '1', 10:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:44 INFO - 'NO_EM_RESTART': '1', 10:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:44 INFO - 'PWD': '/builds/slave/test', 10:40:44 INFO - 'SHELL': '/bin/bash', 10:40:44 INFO - 'SHLVL': '1', 10:40:44 INFO - 'TERM': 'linux', 10:40:44 INFO - 'TMOUT': '86400', 10:40:44 INFO - 'USER': 'cltbld', 10:40:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:44 INFO - '_': '/tools/buildbot/bin/python'} 10:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:40:44 INFO - Cleaning up... 10:40:44 INFO - Return code: 0 10:40:44 INFO - Running post-action listener: _resource_record_post_action 10:40:44 INFO - Running post-action listener: _start_resource_monitoring 10:40:44 INFO - Starting resource monitoring. 10:40:44 INFO - [mozharness: 2016-09-17 17:40:44.800355Z] Finished create-virtualenv step (success) 10:40:44 INFO - [mozharness: 2016-09-17 17:40:44.800853Z] Running install step. 10:40:44 INFO - Running pre-action listener: _resource_record_pre_action 10:40:44 INFO - Running main action method: install 10:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:45 INFO - Reading from file tmpfile_stdout 10:40:45 INFO - Detecting whether we're running mozinstall >=1.0... 10:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:40:45 INFO - Reading from file tmpfile_stdout 10:40:45 INFO - Output received: 10:40:45 INFO - Usage: mozinstall [options] installer 10:40:45 INFO - Options: 10:40:45 INFO - -h, --help show this help message and exit 10:40:45 INFO - -d DEST, --destination=DEST 10:40:45 INFO - Directory to install application into. [default: 10:40:45 INFO - "/builds/slave/test"] 10:40:45 INFO - --app=APP Application being installed. [default: firefox] 10:40:45 INFO - mkdir: /builds/slave/test/build/application 10:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:41:01 INFO - Reading from file tmpfile_stdout 10:41:01 INFO - Output received: 10:41:01 INFO - /builds/slave/test/build/application/firefox/firefox 10:41:01 INFO - Running post-action listener: _resource_record_post_action 10:41:01 INFO - [mozharness: 2016-09-17 17:41:01.142121Z] Finished install step (success) 10:41:01 INFO - [mozharness: 2016-09-17 17:41:01.142368Z] Running run-tests step. 10:41:01 INFO - Running pre-action listener: _resource_record_pre_action 10:41:01 INFO - Running main action method: run_tests 10:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:41:01 INFO - Python 2.7.3 10:41:01 INFO - Return code: 0 10:41:01 INFO - grabbing minidump binary from tooltool 10:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:01 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 0x100df60>, '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 0x100ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:41:01 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 10:41:01 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 10:41:01 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 10:41:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:41:01 INFO - Return code: 0 10:41:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:41:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:41:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:41:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:41:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:41:01 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:41:01 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 10:41:01 INFO - Using env: {'DISPLAY': ':0', 10:41:01 INFO - 'HOME': '/home/cltbld', 10:41:01 INFO - 'LANG': 'en_US.UTF-8', 10:41:01 INFO - 'LANGUAGE': 'en_US:en', 10:41:01 INFO - 'LOGNAME': 'cltbld', 10:41:01 INFO - 'MAIL': '/var/mail/cltbld', 10:41:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:41:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:01 INFO - 'MOZ_NO_REMOTE': '1', 10:41:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:01 INFO - 'NO_EM_RESTART': '1', 10:41:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:01 INFO - 'PWD': '/builds/slave/test', 10:41:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:41:01 INFO - 'SHELL': '/bin/bash', 10:41:01 INFO - 'SHLVL': '1', 10:41:01 INFO - 'TERM': 'linux', 10:41:01 INFO - 'TMOUT': '86400', 10:41:01 INFO - 'USER': 'cltbld', 10:41:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351', 10:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:01 INFO - '_': '/tools/buildbot/bin/python'} 10:41:01 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:41:01 INFO - mozversion application_buildid: 20160916143618 10:41:01 INFO - mozversion application_changeset: f2fe5345c13ff5ec70dc259d653298a7cac61423 10:41:01 INFO - mozversion application_display_name: Nightly 10:41:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:41:01 INFO - mozversion application_name: Firefox 10:41:01 INFO - mozversion application_remotingname: firefox 10:41:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:41:01 INFO - mozversion application_vendor: Mozilla 10:41:01 INFO - mozversion application_version: 51.0a1 10:41:01 INFO - mozversion platform_buildid: 20160916143618 10:41:01 INFO - mozversion platform_changeset: f2fe5345c13ff5ec70dc259d653298a7cac61423 10:41:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:41:01 INFO - mozversion platform_version: 51.0a1 10:41:01 INFO - using testdate: 1474134061 10:41:01 INFO - actual date: 1474134061 10:41:01 INFO - starting webserver on 'localhost:44931' 10:41:01 INFO - SUITE-START | Running 2 tests 10:41:01 INFO - TEST-START | dromaeo_css 10:41:01 INFO - operating with platform_type : linux_ 10:41:01 INFO - Initialising browser for dromaeo_css test... 10:41:01 INFO - TEST-INFO | started process 10899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdlslhv/profile http://localhost:44931/getInfo.html) 10:41:06 INFO - PROCESS | 10899 | __metrics Screen width/height:1600/1200 10:41:06 INFO - PROCESS | 10899 | colorDepth:24 10:41:06 INFO - PROCESS | 10899 | Browser inner width/height: 1024/697 10:41:06 INFO - PROCESS | 10899 | __metrics 10:41:06 INFO - PROCESS | 10899 | 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" 10:41:06 INFO - PROCESS | 10899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:41:07 INFO - PROCESS | 10899 | console.error: PushService: 10:41:07 INFO - PROCESS | 10899 | stateChangeProcessEnqueue: Error transitioning state 10:41:07 INFO - PROCESS | 10899 | UnknownError 10:41:07 INFO - TEST-INFO | 10899: exit 0 10:41:07 INFO - Browser initialized. 10:41:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:41:07 INFO - TEST-INFO | started process 10982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdlslhv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:20 INFO - PROCESS | 10982 | RSS: Main: 174219264 10:41:20 INFO - PROCESS | 10982 | 10:41:23 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.15004 seconds. 10:41:55 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 7.11697 seconds. 10:41:57 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:42:06 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:42:10 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:42:11 INFO - PROCESS | 10982 | 1474134131981 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] 10:42:23 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:42:31 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.60006 seconds. 10:42:41 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:42:44 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 10:42:52 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:43:01 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.05009 seconds. 10:43:09 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:43:15 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:43:30 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.16671 seconds. 10:43:40 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:43:43 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:43:44 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 2.00006 seconds. 10:43:45 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:43:52 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:43:59 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:44:02 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:44:09 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:44:16 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:44:22 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.4334 seconds. 10:44:24 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 10:44:24 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44931/tests/dromaeo/cssquery-ext.html) 10:44:26 INFO - PROCESS | 10982 | RSS: Main: 283340800 10:44:26 INFO - PROCESS | 10982 | 10:44:29 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:44:30 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01663 seconds. 10:44:39 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:44:48 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:44:50 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:44:58 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:45:00 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:45:26 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 10:45:33 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:45:45 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:45:55 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:45:59 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 10:46:01 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:46:03 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 10:46:05 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:46:09 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:11 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:46:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:46:19 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 10:46:25 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:46:28 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:30 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:32 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:46:36 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:46:42 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:46:46 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:46:48 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:55 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:56 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:46:58 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:47:16 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:47:28 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-ext.html (next: http://localhost:44931/tests/dromaeo/cssquery-jquery.html) 10:47:29 INFO - PROCESS | 10982 | RSS: Main: 276254720 10:47:29 INFO - PROCESS | 10982 | 10:47:32 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:47:35 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 10:47:38 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:47:39 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:47:47 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:47:55 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:48:12 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:48:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01686 seconds. 10:48:20 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 10:48:22 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:48:24 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:48:28 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:48:33 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 10:48:34 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:48:36 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:48:38 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:49:06 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:49:10 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:49:48 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:49:54 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 2 seconds. 10:49:54 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 2 seconds. 10:49:55 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:49:57 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:49:59 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 10:50:01 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:50:05 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:50:07 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:50:11 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:50:25 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:50:29 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:50:31 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44931/tests/dromaeo/cssquery-mootools.html) 10:50:32 INFO - PROCESS | 10982 | RSS: Main: 259801088 10:50:32 INFO - PROCESS | 10982 | 10:50:35 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 10:50:36 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:51:00 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:51:01 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 10:51:03 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 10:51:11 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:51:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 2.01673 seconds. 10:51:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 2.01673 seconds. 10:51:17 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:51:21 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:35 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:47 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:52:00 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:52:15 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:17 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:19 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:23 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:52:27 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:31 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:52:40 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:52 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:52:54 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 10:52:56 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 10:53:02 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:53:04 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:53:06 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:53:11 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:53:12 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:53:34 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:53:34 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44931/tests/dromaeo/cssquery-prototype.html) 10:53:35 INFO - PROCESS | 10982 | RSS: Main: 217653248 10:53:35 INFO - PROCESS | 10982 | 10:53:38 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:53:51 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:54:00 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:54:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:54:16 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:30 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:32 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:39 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:55:00 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:55:06 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:55:24 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:55:27 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:55:41 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:55:43 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:56:01 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:56:26 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:56:32 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:56:35 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:56:38 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44931/tests/dromaeo/cssquery-yui.html) 10:56:38 INFO - PROCESS | 10982 | RSS: Main: 218746880 10:56:38 INFO - PROCESS | 10982 | 10:56:44 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:56:46 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:48 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:59 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00196 seconds. 10:57:05 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:08 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 10:57:13 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:17 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:57:36 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:52 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:57:54 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:58:09 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:58:14 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:58:28 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:58:34 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:58:36 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:58:38 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:58:40 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:58:57 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:59:04 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 10:59:09 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:59:13 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:59:15 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 10:59:22 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 10:59:35 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:59:41 INFO - PROCESS | 10982 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:59:41 INFO - PROCESS | 10982 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-yui.html (next: http://localhost:44931/tests/dromaeo/cssquery-dojo.html) 10:59:42 INFO - PROCESS | 10982 | RSS: Main: 299118592 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | __start_tp_report 10:59:42 INFO - PROCESS | 10982 | _x_x_mozilla_page_load 10:59:42 INFO - PROCESS | 10982 | _x_x_mozilla_page_load_details 10:59:42 INFO - PROCESS | 10982 | |i|pagename|runs| 10:59:42 INFO - PROCESS | 10982 | |0;dojo.html;2611.7388261173887;2643.616675582042;2673.438577898641;2683.0475181310635;2695.4070104577;4588.426446694163;4665.346851440801;4738.597219236365;4799.472058073609;4850.32095506629;4693.155232058228;4722.763861806904;4738.928916066253;4763.6665433419585;4784.90430191396;4379.627731642814;4392.6266267367155;4412.095520418323;4433.911321773563;4516.570925762064;4468.932966005496;4482.8879278017985;4487.371767952489;4503.054358584701;4515.277555591106;4253.851115210984;4278.080212754242;4440.933385999213;4469.776511174445;4476.306172543261;4328.718633288858;4347.2826983547675;4373.540778218273;4391.077873646538;4446.377507149002;4341.544137865541;4350.086481838817;4353.804078816461;4353.978230108861;4396.890077748082;4733.479317275097;4770.236762118079;4776.785044672998;4780.4741478437345;4786.401699787527;5031.748412579356;5083.389993200803;5089.41471730752;5098.337216161913;5160.535551800319;5150.819721309736;5151.098557752378;5151.484851514856;5198.662086964373;5207.6354655174155;4809.78355973982;4814.133455977958;4817.9518204818205;4818.71087734737;4874.147024270738;5041.092603331363;5078.669886457368;5083.949160508421;5274.709890955957;5275.20871869215;4885.4870238624435;4925.827596034122;4933.6299777516115;4935.728534930613;4983;5131.4868513148385;5139.177731562932;5170.224466330081;5177.119889618773;5182.507661772125;4958.826441074545;5009.248612708123;5010.498950105033;5072.442031376546;5132.538071573576;5049.6465247432325;5053.620978426633;5056.570191533688;5057.266696329085;5061.974690126526;4138.544760076389;4173.269677806372;4181.498220213533;4196.223698615766;4248.086661367821;3689.0408493791806;3689.6494832990825;3690.151265209017;3735.084904198489;3736.1220113273357;4354.325079612665;4375.081232941118;4381.956180438155;4402.141582391467;4431.290993441034;4966.15575352191;5022.271770593316;5066.265391518209;5097.6941383517105;5131.538161565477;4424.048829501673;4432.711873728197;4471.776411179428;4489.775511224426;4493.1013797240685;4539.659525535598;4544.341070544752;4544.750038747835;4546.931796023062;4606.262997920384;4664.463586687574;4701.247800351927;4817.27740838863;4870.05034018363;4880.682755620874;5142.64001519905;5159.17453207485;5178.43037265908;5179.559737422362;5242.5281724644965;4871.8294859679745;4901.583365413837;4902.436219834622;4917.704937703749;4921.360223170965;4856.39295088114;4908.8772780680765;5035;5052.065367906949;5053.082132400642;5058.772355244097;5103.948960510347;5114;5132.358455193101;5183.585313175013;4971.65198436106;4972.552470277692;4974.502549745142;4975.452700203047;5036.370453693288;4774.4509381421585;4947.480514546065;4974.726390048582;4989.60083193351;5045.62157838171;4770.379850619397;4807.086653535817;4813.302071199727;4819.783109760139;4880.46314905353;4861.6596838220985;4882.487338829372;4894.14352488306;4923.236898280772;4926.088673595396;4749.976250118727;4786.569208771228;4800.207965685623;4838.443578988461;4841.757912104451 10:59:42 INFO - PROCESS | 10982 | |1;ext.html;563.3408911573462;570.1476292942051;574.971251437428;589.3487696095814;594.5778497266939;27571.862140689293;29894.1031769047;29916.70083299169;40983.59016409835;42256;39916.40125398121;40288.59711402885;40303.79848100755;40322.7983860081;40343.39484907729;7472.065991751031;7660.348870346;7668.309852113309;7668.309852113309;7668.616569171547;7403.518771279876;7504.887426688577;7506.3861269826975;7509.586972716498;7512.9624351878165;7502.137254215753;7528.096628404599;7546.320831125197;7546.396288296951;7550.735724249653;7447.88828167578;7497.212792656802;7504.437167212481;7504.699812007513;7514.549127052394;5485.396606373296;5534.75093620788;5538.196961440569;5538.224648549206;5539.944600553983;36573.268534629424;36743.26513469742;36763.448548271794;36872.44691329632;36881.81559092214;2731.7951153663553;2769.5568709006666;2770.7783377329965;2773.4037182005964;2877.4820532304175;27420.451590968267;27843.582346264822;27965.44069118606;28191.295217619518;28503.714962850314;3100.8442451775013;3105.3013072058607;3124.218945263684;3154.9053528394184;3214.694604012615;238685;240952.79523602445;241568;241961.95095122588;242446.99999999822;49263.75368123208;49286.75356623194;49655;49677.751611242435;49746.25380619294;31586.36827263442;32714.182145446553;32728;51821.48178518242;52293.47706522962;12541.184822986477;12855.1001429899;12860.807087893689;12861.228326300452;12868.678283042998;9391.859122113037;9422.623095076257;9433.76415589602;9434.716958491255;9445.433274003582;17342.393016244623;17378.47864564065;17413;17536.47390578285;17576.736348954775;6404.967975160094;6522.771702990372;6597.977313516412;6635.535512514174;6696.59820410777;731.7365748330596;778.5250996891891;799.9840003199903;856.4903882190087;919.2921450483091;27754.444911101666;28007.71992280092;28095;28163.577546336823;28578;860.655737704923;876.68001179569;878.1262643669589;893.8659201119884;905.8867641544807;13982.300884955712;14745.77881331781;14853.897317091441;14902.925485372503;15091.169985650675;363644;406680;415155;680151;681526;48554.27168592474;49131.263031054565;49171.262431063566;49209;49287.75356123196;1102.8676558812995;1109.439732934879;1121.7532142928542;1125.1224045244721;1125.4147843121696;26993.59509607397;27683;27887.302817429725;28804.711952880203;29009.7099029007;40166;40698.79650601728;40729.796351018056;40838.79580602078;40896;265331;266350;267572;268203;268256;24520.877395612908;24891.626625600267;24901;24909;24930.252092437255;39571.406428903014;39602.207955840146;39778.80110599429;39964.40053399259;41290.38064428976;34295.31409371749;34506;34563.82718086393;34728.826355868056;34919;33390.83304583462;34071.82964085263;34355.65644343525;34477.82761086279;35199.47200792041;27336.589951151145;28925.276868078465;33990;34075.82962085273;34186.14534636654;25086.874565627055;29393.412131756817;31542.842285789342;31791.682083178872;31794.68205317917;21822.672659910433;22398.888005559867;22939.426514336606;23000.309990700305;23180.18869339565 10:59:42 INFO - PROCESS | 10982 | |2;jquery.html;317.31934999426215;332.28061247399364;358.15654134513227;358.45872732174416;365.9158393569479;10681.626143084985;14458.349374278156;15170.772438413418;15926.362945482168;16778.496645100637;13800;13991.370388332523;16266.268017939192;17056.914715426406;17215.397461088865;3977.1449138435305;4147.771872547009;4149.9792501037455;4156.480439945007;4178.665706743468;4900.950990490103;5004.149294619905;5007.974960125212;5010;5010.774515146809;4978.626603004771;4980.452150263468;4988.426330971948;4989.10196164692;5005.174146265862;4753.857384278477;4897.118518666621;4919.631027672939;4924.901501969976;4927.014597080562;4388.385626012361;4391.253486907233;4391.341298805173;4392.0776636906285;4394.318880573516;18651.626967460576;19462.610747785107;19702.507437314038;19743.308984185485;19772.20911163552;1752.2377765671974;2217.9778202218095;2268.5236100418933;2270.7729227077325;2300.0799680127916;8827.073157318453;8930.508822014786;9189.862152067724;9213.170814626648;9784.461854597994;1767.6553072150807;1800.2349001674368;1833.7249412588085;1855.9164837582207;1901.1349835824806;63495.365046349405;65953.34046659568;66061.33938660599;67405.3259467404;68104.6594767023;9322.394044387092;9585;9746.707598772047;9873.851892221479;10075.496225188712;11773.764524709457;12288.508459661693;25751.227463176136;27140.45719085647;27267.590986135223;8028.678852845937;8174.9182508175345;8312.168783121639;8505.48967061966;8623.741287761377;6553.0170474429215;6682.966585167043;6718.294579069225;6911.654417279216;7055.1886533049355;6948.456287293416;7259.564426134449;7588.506747061423;7991.640376183086;8305.418620696613;3229.434848901433;3253.3330667213163;3254.7884387514737;3266.738660907122;3307.68576985186;343.48820257816175;344.04698983814694;748.330244431231;783.0994356490082;907.7004588485784;9320.533973301443;10076;10277.17782577407;10341.896581034243;10422.739431514272;377.25303898281555;378.6459660217705;381.967532759713;388.3611459149739;400.1656546101353;5081.526357356325;5270.789168433296;5354.518093371616;5532.3637781655625;5662.17898404729;356894;363248;375270;398256;408192;81935.59032204801;81965;83204.58397707973;83509;83526;405.4404921208772;413.4022004950903;414.6641220611314;414.7428594271571;415.4640513737245;9485.905140948502;9512.33413661037;9583.185429238314;9589.424634521672;9598.95200523993;28458.57312140361;35053.443052403025;35113.47329790004;36199.27601447904;37238.6276137246;48402;48663.75668121778;48853.51146488632;49346;49503.75248123737;7137.2149063604;7151.141862976476;7342.229065947999;7517.774466766005;7581.772546823604;6031.728572214173;10632.255742098288;10829.945850270698;10851.620193293196;11133.109351251718;9670.323077384797;9762.46306453152;9983.650572229937;10045.196384289093;10502.579896804347;10249.9487502562;10318.587256509656;10346.32748871321;10379.429131397543;10393.688189354332;10302.475893405865;10464.37213767146;10562.947185264333;10860.239783215098;10860.565577376816;7125.218695326168;7406.444516661164;7464.552126872405;7652.73215437457;7761.92238077612;9893.505324733878;10098.545565449425;10167.644132455329;10359.171266298828;10548.367097974146 10:59:42 INFO - PROCESS | 10982 | |3;mootools.html;1320.7556602028626;1347.8449978252502;1360.4354193009895;1585.9303608790524;1625.439223467904;6595.7031933562985;6879.5872247665175;7076.575405475669;7626.428017898659;7626.809329766758;7048.647567621611;7390.2609739026075;7400.925990740091;7503.962480187605;7550.848983020336;2086.551391450838;2116.0689296709475;2117.5553133841913;2142.882141482218;2145.0883374565824;1706.940257091002;2067.8345732341377;2111.166089394696;2140.464883779055;2146.1737231166035;1824.1700026487915;2011.0749055434444;2072.533679922013;2079.7088407622946;2080.178329559823;2071.85497015209;2072.554400803827;2075.533005073854;2076.9792302076935;2081.2715549557684;2050.6513892638286;2083.5312054787705;2086.634838903201;2088.6553718636405;2094.0786054136283;7620.61896905158;7669.38644908406;7679;7687.077550693896;7687.192844751333;4133.524644665872;4251.744895306291;4253.425787518676;4253.425787518676;4281.336392859112;2674.652295201611;2783.0815830775796;2795.594638777386;2814.788890833175;2817.3377707152877;866.1814585216972;895.9148880856374;915.5513798238882;919.2508105893676;921.1019256225194;10249.436281004542;10253.949210157998;10303.845442318372;10307.12389446898;10315.226358023103;3781.8487260509823;3916.921661566753;4041;4103.958960410418;4104.630583247463;8779.429337093195;8808.383413161017;8809.911900881038;8823.205911467998;8843.204111629984;4254.170436764801;4276.080642661843;4288.52826189119;4292.141571685675;4300.075483771005;3949.822257998397;3963.8810835674976;3971.5035620547433;3979.2041591681777;3981.5819338969573;3259.2992506611195;3380.4253276942977;3387.441072223105;3402.9829850851083;3432.090496018557;928.8281667891462;994.1400688404478;1005.0552480668294;1008.047395211518;1028.2236911132047;543.7444401131462;660.1582981698277;665.7237246542727;691.0843132848995;691.3017851969446;4696.38946936896;4741.786619602126;4850.223964165787;4879.878003049881;4921.557059864558;796.5977181523293;822.5845947796444;837.8031162676766;844.5558095656373;855.4354126276752;3224.4840825467813;3269.411505928908;3314.121757734202;3326.916827079294;3542.132177616449;9040.593173307218;9486.146246837818;9499.477528735986;9500.23998080152;9502.47736374506;9418.670346537838;9455.52722363879;9479.620815167455;9536.713898583053;9539.666111686058;7095.467839912028;7240.1311842579225;7250.673719682627;7254.637268136677;7260.128784545783;4995.975020124876;5174.560162386239;5263.947360526499;5291.550218231493;5425.945740542702;8418.494890306602;8542.18849209324;8571.314294856522;8581.528015959182;8587.484750914966;8369.790755231168;8489.915100848912;8569.65721371163;8625.913740862761;8845.380823342304;6339.683015849281;6503.317151699003;6523.282438931618;6527.934720652733;6541.771038013647;6818.8636227276165;6872.072270243653;6875.724971001104;6879.862402752017;6884.793456196322;5809.564282678732;5994.940050599438;6099.8780024398375;6129.049997250433;6175.7838475654935;5986.431289027535;6110.114033465212;6119.816405507842;6128.203333566607;6145.661988590492;5770.826875193751;5794;5795.681237531976;5799.159121927212;5875.823725288248;4374.922284946931;4430.357598148186;4444.977775111104;4480.977595112004;4593.402857628487;4339.934900976551;4445.133199026159;4449.17690227309;4456.554344565518;4461.8622251325705 10:59:42 INFO - PROCESS | 10982 | |4;prototype.html;285.308127790109;294.47142379428925;296.68995899285244;303.96352437707463;305.5203330770691;4934.506549345068;4948.253719185859;4956.132676781558;4969.826056088038;4980.352554167957;4838.685485443444;4875.122477953967;4902.926456103161;4902.940764878751;4911.80352785889;3606.5311509503726;3699.6855267302312;3700.481932529448;3767.60440153784;3802.6007269236748;3803.8288277027464;3809.619038096182;3810.047488127968;3810.428435734634;3832.693384529245;3752.906177345561;3779.2063666630042;3781.054736315921;3797.2405518896194;3806.7525610835346;3635.6548077211337;3641.8725344612812;3739.8317075731657;3756.267527832074;3811.5235595550557;3327.7670563060597;3333.3833240850277;3335.699077359832;3337.466005439118;3352.932941341184;4715.434147902273;4724.913269947897;4735.526447355237;4740.312654665055;4750.501197374295;4190.769507677077;4351.434313539251;4351.543087975749;4364.236258654722;4382.496012958519;5056.620753443506;5071.1632580624155;5073.239014147871;5079.6698214615935;5088.821891233826;3662.8351724172476;3671.963280367189;3685.4287585424304;3687.7049836013052;3694.18727879866;5151.304573882516;5291.603129765283;5327.227552004976;5338.225957236179;5380.273663055476;3743.9438408423352;3755.286495565834;3755.868544600926;3758.2107757370713;3771.641694039062;3800.7529510582276;3820.598837122118;3833.3483307837732;3836.3478208704587;3838.405047217686;4324.0919406924895;4366.476022877211;4368.104538569585;4371.650267978554;4372.715773474714;4814.301926220678;5100.1074811907765;5111.386633603991;5135.6918584885025;5146.305248791366;1320.735852829438;1342.1745626439865;1342.89256859451;1344.327836081959;1348.5347555093476;811.9472234304869;843.7510934274404;875.8773771671971;887.2148148888281;890.2966656341417;4376.190404775063;4405.361222622766;4496.527864574238;4541.273396256649;4556.476005259371;5234.398044224887;5238.371395432572;5247.344081989751;5251.238570407269;5271.077561426811;4543.318502224693;4550.292575917324;4564.954350456519;4580.312953057001;4581.702189357681;2660.2152365052357;2765.5160346939206;2782.664321125871;2786.8327900326044;2787.958180627292;4956.776945037482;4962.925556116661;4972.154733695208;4979.925301120486;4999.700077979679;5147.485251474897;5368.436314187033;5369.69763595386;5378.811741589026;5395.514403703685;4924.227278179852;4953.356063711694;4965.4041515018425;4974.303597496353;4979.30289759434;5195.76619052136;5211.9478805212975;5213.218017297284;5238.738063096906;5243.265942767939;4999.975000124976;5135.820246291362;5143.382794064587;5159.380874295109;5169.147090730138;4948.406191257072;4950.801967921243;4952.8761780955765;4963.801447942042;4964.925526117184;3725.7950812704476;3733.5706393765063;3751.230997645531;3770.8114594269628;3774.245150969762;5121.4661883300405;5162.716050617252;5270.657407268515;5274.551663108526;5296.311479507639;5057.14028615129;5068.214426763858;5073.34046573943;5077.492250775041;5106.157484015096;4969.229769385751;5085.821996230115;5092.567131793691;5105.846824595268;5132;4724.763761811964;4984;5009.173486374707;5025.84922452327;5047.520485553867;4800;4937.876553086058;4977.178765503651;5033.773480193327;5078.669886457368;4977.701337919736;4984.127777638826;5019.749012549285;5030.270610761492;5035.949640503548 10:59:42 INFO - PROCESS | 10982 | |5;yui.html;538.494980633942;560.6551970538119;571.5656101362965;600.0938582740063;615.3508049008294;11471.713207169814;11952.820707689392;12066.215695979756;12103.455344509497;12105.818412723816;12248.632541023784;12410.751784964295;12411.317377544232;12432.44054017569;12600.369981500911;585.066818424612;724.7282269149069;743.8400743840074;745.7986343687202;746.6789280609336;605.6033298189693;612.8130920069377;613.9938600614004;717.7057406463351;746.0711414289218;790.1782146567563;792.6987744657022;792.8097256658418;792.8295416485455;793.0404210904812;786.6381464526324;786.9960650196713;787.0437418536477;787.086979104242;787.6022608582658;452.69669321554636;460.56016504238374;463.11776066593194;577.3216470647016;577.7053702611656;9718.70843874685;11810.88189118115;12271;12290.938545307306;12351.567695130718;11874.228175168586;13088.672783180402;13119.409626566732;13485.460581576725;13628.114172578751;12001.63995080149;12032.27806331623;12253.387330633434;12255.877441225563;13173.209607423489;4084.7957602119777;4154.480689913761;4213.51544572375;4214.115035842477;4214.662826973866;62165.6891715543;62411;62558.68720656368;63424.04863927045;63776.681116594584;10297.330673506198;10584.629537966135;10635.617369741884;10771.892281077246;11098.889011109786;19105.331313403964;19187.90406047961;19262.13320400557;19315.710264346046;19668.311609093613;6673.1992160941;6704.932950670528;6718.865622687616;6851.520393572402;6976.7558135465015;3475.6350583188905;3575.481555174485;3600.225951420457;3729.8321575529167;3802.733808633369;2548.13363456422;2587.1333103410193;2607.752263534961;2609.6868375795025;2610.6084087387044;455.24883941496796;461.1284671969979;464.45194670289385;468.8335640847518;475.2135216217166;383.48995835538665;443.07397539142704;452.60623257765957;457.0630208073436;480.64912613792126;6986.196587392414;7156.570605763567;7162.534435261691;7333.633318334062;7472.85054298911;458.20730136863415;464.7304563353247;469.7533794757711;470.85168172025703;479.8848276413636;3463.255400088993;3517.6306487818924;3572.481990111471;3662.9052480745036;3665.6700896918874;74747;76097.61951190208;100380;105851.47074264579;106062.46968765107;47429;47655;47959.04081918342;48719.5128048722;74073;55025.44974550203;68017.3198268021;71282.2871771286;73703.6314818444;75971.86042209371;7729.955951536828;7955.920440795518;8195.754127376189;8219.506829590004;8514;44730.329045065;44822.3276650844;46042.53957460383;46488.767556162005;46920.29619555778;55386;65969;65984.03071861874;66121.66939165466;66896;10462.529186186488;10566.735831604272;10679.359238445719;10962.56149754001;10997.12023038171;11507.42462876836;11557.47991340375;11748.941255293668;12162.148649594443;12219.877801221874;11651.825222621837;11799.115066369885;12233.571824986082;12411.441485133371;12628.11603187768;11478.885211148116;11652.53389864396;12115.394230288626;12334.50661973511;12458.127931044739;11055.889441105486;11178.119848806884;11404.771904562029;11667.299962002307;11863.644090677293;9133.588988495667;9444.811103777749;9841.803163936538;9876.111149996535;10068.395896245956;9623.807523849624;10013.741411617739;10068.44623545712;10136.391816491034;10205.897941020792 10:59:42 INFO - PROCESS | 10982 | __end_tp_report 10:59:42 INFO - PROCESS | 10982 | __start_cc_report 10:59:42 INFO - PROCESS | 10982 | _x_x_mozilla_cycle_collect,1013 10:59:42 INFO - PROCESS | 10982 | __end_cc_report 10:59:42 INFO - PROCESS | 10982 | __startTimestamp1474135182241__endTimestamp 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | ------- Summary: start ------- 10:59:42 INFO - PROCESS | 10982 | Number of tests: 6 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#0] dojo.html Cycles:165 Average:4701.45 Median:4818.71 stddev:496.07 (10.3%) stddev-sans-first:469.72 10:59:42 INFO - PROCESS | 10982 | Values: 2611.7 2643.6 2673.4 2683.0 2695.4 4588.4 4665.3 4738.6 4799.5 4850.3 4693.2 4722.8 4738.9 4763.7 4784.9 4379.6 4392.6 4412.1 4433.9 4516.6 4468.9 4482.9 4487.4 4503.1 4515.3 4253.9 4278.1 4440.9 4469.8 4476.3 4328.7 4347.3 4373.5 4391.1 4446.4 4341.5 4350.1 4353.8 4354.0 4396.9 4733.5 4770.2 4776.8 4780.5 4786.4 5031.7 5083.4 5089.4 5098.3 5160.5 5150.8 5151.1 5151.5 5198.7 5207.6 4809.8 4814.1 4818.0 4818.7 4874.1 5041.1 5078.7 5083.9 5274.7 5275.2 4885.5 4925.8 4933.6 4935.7 4983.0 5131.5 5139.2 5170.2 5177.1 5182.5 4958.8 5009.2 5010.5 5072.4 5132.5 5049.6 5053.6 5056.6 5057.3 5062.0 4138.5 4173.3 4181.5 4196.2 4248.1 3689.0 3689.6 3690.2 3735.1 3736.1 4354.3 4375.1 4382.0 4402.1 4431.3 4966.2 5022.3 5066.3 5097.7 5131.5 4424.0 4432.7 4471.8 4489.8 4493.1 4539.7 4544.3 4544.8 4546.9 4606.3 4664.5 4701.2 4817.3 4870.1 4880.7 5142.6 5159.2 5178.4 5179.6 5242.5 4871.8 4901.6 4902.4 4917.7 4921.4 4856.4 4908.9 5035.0 5052.1 5053.1 5058.8 5103.9 5114.0 5132.4 5183.6 4971.7 4972.6 4974.5 4975.5 5036.4 4774.5 4947.5 4974.7 4989.6 5045.6 4770.4 4807.1 4813.3 4819.8 4880.5 4861.7 4882.5 4894.1 4923.2 4926.1 4750.0 4786.6 4800.2 4838.4 4841.8 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#1] ext.html Cycles:180 Average:47680.87 Median:199421.74 stddev:98870.53 (49.6%) stddev-sans-first:99084.60 10:59:42 INFO - PROCESS | 10982 | Values: 563.3 570.1 575.0 589.3 594.6 27571.9 29894.1 29916.7 40983.6 42256.0 39916.4 40288.6 40303.8 40322.8 40343.4 7472.1 7660.3 7668.3 7668.3 7668.6 7403.5 7504.9 7506.4 7509.6 7513.0 7502.1 7528.1 7546.3 7546.4 7550.7 7447.9 7497.2 7504.4 7504.7 7514.5 5485.4 5534.8 5538.2 5538.2 5539.9 36573.3 36743.3 36763.4 36872.4 36881.8 2731.8 2769.6 2770.8 2773.4 2877.5 27420.5 27843.6 27965.4 28191.3 28503.7 3100.8 3105.3 3124.2 3154.9 3214.7 238685.0 240952.8 241568.0 241962.0 242447.0 49263.8 49286.8 49655.0 49677.8 49746.3 31586.4 32714.2 32728.0 51821.5 52293.5 12541.2 12855.1 12860.8 12861.2 12868.7 9391.9 9422.6 9433.8 9434.7 9445.4 17342.4 17378.5 17413.0 17536.5 17576.7 6405.0 6522.8 6598.0 6635.5 6696.6 731.7 778.5 800.0 856.5 919.3 27754.4 28007.7 28095.0 28163.6 28578.0 860.7 876.7 878.1 893.9 905.9 13982.3 14745.8 14853.9 14902.9 15091.2 363644.0 406680.0 415155.0 680151.0 681526.0 48554.3 49131.3 49171.3 49209.0 49287.8 1102.9 1109.4 1121.8 1125.1 1125.4 26993.6 27683.0 27887.3 28804.7 29009.7 40166.0 40698.8 40729.8 40838.8 40896.0 265331.0 266350.0 267572.0 268203.0 268256.0 24520.9 24891.6 24901.0 24909.0 24930.3 39571.4 39602.2 39778.8 39964.4 41290.4 34295.3 34506.0 34563.8 34728.8 34919.0 33390.8 34071.8 34355.7 34477.8 35199.5 27336.6 28925.3 33990.0 34075.8 34186.1 25086.9 29393.4 31542.8 31791.7 31794.7 21822.7 22398.9 22939.4 23000.3 23180.2 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#2] jquery.html Cycles:180 Average:23563.63 Median:4167.57 stddev:63111.77 (1514.4%) stddev-sans-first:63264.68 10:59:42 INFO - PROCESS | 10982 | Values: 317.3 332.3 358.2 358.5 365.9 10681.6 14458.3 15170.8 15926.4 16778.5 13800.0 13991.4 16266.3 17056.9 17215.4 3977.1 4147.8 4150.0 4156.5 4178.7 4901.0 5004.1 5008.0 5010.0 5010.8 4978.6 4980.5 4988.4 4989.1 5005.2 4753.9 4897.1 4919.6 4924.9 4927.0 4388.4 4391.3 4391.3 4392.1 4394.3 18651.6 19462.6 19702.5 19743.3 19772.2 1752.2 2218.0 2268.5 2270.8 2300.1 8827.1 8930.5 9189.9 9213.2 9784.5 1767.7 1800.2 1833.7 1855.9 1901.1 63495.4 65953.3 66061.3 67405.3 68104.7 9322.4 9585.0 9746.7 9873.9 10075.5 11773.8 12288.5 25751.2 27140.5 27267.6 8028.7 8174.9 8312.2 8505.5 8623.7 6553.0 6683.0 6718.3 6911.7 7055.2 6948.5 7259.6 7588.5 7991.6 8305.4 3229.4 3253.3 3254.8 3266.7 3307.7 343.5 344.0 748.3 783.1 907.7 9320.5 10076.0 10277.2 10341.9 10422.7 377.3 378.6 382.0 388.4 400.2 5081.5 5270.8 5354.5 5532.4 5662.2 356894.0 363248.0 375270.0 398256.0 408192.0 81935.6 81965.0 83204.6 83509.0 83526.0 405.4 413.4 414.7 414.7 415.5 9485.9 9512.3 9583.2 9589.4 9599.0 28458.6 35053.4 35113.5 36199.3 37238.6 48402.0 48663.8 48853.5 49346.0 49503.8 7137.2 7151.1 7342.2 7517.8 7581.8 6031.7 10632.3 10829.9 10851.6 11133.1 9670.3 9762.5 9983.7 10045.2 10502.6 10249.9 10318.6 10346.3 10379.4 10393.7 10302.5 10464.4 10562.9 10860.2 10860.6 7125.2 7406.4 7464.6 7652.7 7761.9 9893.5 10098.5 10167.6 10359.2 10548.4 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#3] mootools.html Cycles:180 Average:4886.03 Median:5277.75 stddev:2783.67 (52.7%) stddev-sans-first:2778.58 10:59:42 INFO - PROCESS | 10982 | Values: 1320.8 1347.8 1360.4 1585.9 1625.4 6595.7 6879.6 7076.6 7626.4 7626.8 7048.6 7390.3 7400.9 7504.0 7550.8 2086.6 2116.1 2117.6 2142.9 2145.1 1706.9 2067.8 2111.2 2140.5 2146.2 1824.2 2011.1 2072.5 2079.7 2080.2 2071.9 2072.6 2075.5 2077.0 2081.3 2050.7 2083.5 2086.6 2088.7 2094.1 7620.6 7669.4 7679.0 7687.1 7687.2 4133.5 4251.7 4253.4 4253.4 4281.3 2674.7 2783.1 2795.6 2814.8 2817.3 866.2 895.9 915.6 919.3 921.1 10249.4 10253.9 10303.8 10307.1 10315.2 3781.8 3916.9 4041.0 4104.0 4104.6 8779.4 8808.4 8809.9 8823.2 8843.2 4254.2 4276.1 4288.5 4292.1 4300.1 3949.8 3963.9 3971.5 3979.2 3981.6 3259.3 3380.4 3387.4 3403.0 3432.1 928.8 994.1 1005.1 1008.0 1028.2 543.7 660.2 665.7 691.1 691.3 4696.4 4741.8 4850.2 4879.9 4921.6 796.6 822.6 837.8 844.6 855.4 3224.5 3269.4 3314.1 3326.9 3542.1 9040.6 9486.1 9499.5 9500.2 9502.5 9418.7 9455.5 9479.6 9536.7 9539.7 7095.5 7240.1 7250.7 7254.6 7260.1 4996.0 5174.6 5263.9 5291.6 5425.9 8418.5 8542.2 8571.3 8581.5 8587.5 8369.8 8489.9 8569.7 8625.9 8845.4 6339.7 6503.3 6523.3 6527.9 6541.8 6818.9 6872.1 6875.7 6879.9 6884.8 5809.6 5994.9 6099.9 6129.0 6175.8 5986.4 6110.1 6119.8 6128.2 6145.7 5770.8 5794.0 5795.7 5799.2 5875.8 4374.9 4430.4 4445.0 4481.0 4593.4 4339.9 4445.1 4449.2 4456.6 4461.9 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#4] prototype.html Cycles:180 Average:4236.10 Median:4902.93 stddev:1225.25 (25.0%) stddev-sans-first:1192.26 10:59:42 INFO - PROCESS | 10982 | Values: 285.3 294.5 296.7 304.0 305.5 4934.5 4948.3 4956.1 4969.8 4980.4 4838.7 4875.1 4902.9 4902.9 4911.8 3606.5 3699.7 3700.5 3767.6 3802.6 3803.8 3809.6 3810.0 3810.4 3832.7 3752.9 3779.2 3781.1 3797.2 3806.8 3635.7 3641.9 3739.8 3756.3 3811.5 3327.8 3333.4 3335.7 3337.5 3352.9 4715.4 4724.9 4735.5 4740.3 4750.5 4190.8 4351.4 4351.5 4364.2 4382.5 5056.6 5071.2 5073.2 5079.7 5088.8 3662.8 3672.0 3685.4 3687.7 3694.2 5151.3 5291.6 5327.2 5338.2 5380.3 3743.9 3755.3 3755.9 3758.2 3771.6 3800.8 3820.6 3833.3 3836.3 3838.4 4324.1 4366.5 4368.1 4371.7 4372.7 4814.3 5100.1 5111.4 5135.7 5146.3 1320.7 1342.2 1342.9 1344.3 1348.5 811.9 843.8 875.9 887.2 890.3 4376.2 4405.4 4496.5 4541.3 4556.5 5234.4 5238.4 5247.3 5251.2 5271.1 4543.3 4550.3 4565.0 4580.3 4581.7 2660.2 2765.5 2782.7 2786.8 2788.0 4956.8 4962.9 4972.2 4979.9 4999.7 5147.5 5368.4 5369.7 5378.8 5395.5 4924.2 4953.4 4965.4 4974.3 4979.3 5195.8 5211.9 5213.2 5238.7 5243.3 5000.0 5135.8 5143.4 5159.4 5169.1 4948.4 4950.8 4952.9 4963.8 4964.9 3725.8 3733.6 3751.2 3770.8 3774.2 5121.5 5162.7 5270.7 5274.6 5296.3 5057.1 5068.2 5073.3 5077.5 5106.2 4969.2 5085.8 5092.6 5105.8 5132.0 4724.8 4984.0 5009.2 5025.8 5047.5 4800.0 4937.9 4977.2 5033.8 5078.7 4977.7 4984.1 5019.7 5030.3 5035.9 10:59:42 INFO - PROCESS | 10982 | 10:59:42 INFO - PROCESS | 10982 | [#5] yui.html Cycles:180 Average:16614.30 Median:22637.47 stddev:23084.85 (102.0%) stddev-sans-first:23118.04 10:59:42 INFO - PROCESS | 10982 | Values: 538.5 560.7 571.6 600.1 615.4 11471.7 11952.8 12066.2 12103.5 12105.8 12248.6 12410.8 12411.3 12432.4 12600.4 585.1 724.7 743.8 745.8 746.7 605.6 612.8 614.0 717.7 746.1 790.2 792.7 792.8 792.8 793.0 786.6 787.0 787.0 787.1 787.6 452.7 460.6 463.1 577.3 577.7 9718.7 11810.9 12271.0 12290.9 12351.6 11874.2 13088.7 13119.4 13485.5 13628.1 12001.6 12032.3 12253.4 12255.9 13173.2 4084.8 4154.5 4213.5 4214.1 4214.7 62165.7 62411.0 62558.7 63424.0 63776.7 10297.3 10584.6 10635.6 10771.9 11098.9 19105.3 19187.9 19262.1 19315.7 19668.3 6673.2 6704.9 6718.9 6851.5 6976.8 3475.6 3575.5 3600.2 3729.8 3802.7 2548.1 2587.1 2607.8 2609.7 2610.6 455.2 461.1 464.5 468.8 475.2 383.5 443.1 452.6 457.1 480.6 6986.2 7156.6 7162.5 7333.6 7472.9 458.2 464.7 469.8 470.9 479.9 3463.3 3517.6 3572.5 3662.9 3665.7 74747.0 76097.6 100380.0 105851.5 106062.5 47429.0 47655.0 47959.0 48719.5 74073.0 55025.4 68017.3 71282.3 73703.6 75971.9 7730.0 7955.9 8195.8 8219.5 8514.0 44730.3 44822.3 46042.5 46488.8 46920.3 55386.0 65969.0 65984.0 66121.7 66896.0 10462.5 10566.7 10679.4 10962.6 10997.1 11507.4 11557.5 11748.9 12162.1 12219.9 11651.8 11799.1 12233.6 12411.4 12628.1 11478.9 11652.5 12115.4 12334.5 12458.1 11055.9 11178.1 11404.8 11667.3 11863.6 9133.6 9444.8 9841.8 9876.1 10068.4 9623.8 10013.7 10068.4 10136.4 10205.9 10:59:42 INFO - PROCESS | 10982 | -------- Summary: end -------- 10:59:42 INFO - PROCESS | 10982 | 10:59:43 INFO - TEST-INFO | 10982: exit 0 10:59:43 INFO - TEST-OK | dromaeo_css | took 1121756ms 10:59:43 INFO - TEST-START | kraken 10:59:43 INFO - operating with platform_type : linux_ 10:59:43 INFO - Initialising browser for kraken test... 10:59:43 INFO - TEST-INFO | started process 11285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4si7va/profile http://localhost:44931/getInfo.html) 10:59:47 INFO - PROCESS | 11285 | __metrics Screen width/height:1600/1200 10:59:47 INFO - PROCESS | 11285 | colorDepth:24 10:59:47 INFO - PROCESS | 11285 | Browser inner width/height: 1024/697 10:59:47 INFO - PROCESS | 11285 | __metrics 10:59:48 INFO - PROCESS | 11285 | 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" 10:59:48 INFO - PROCESS | 11285 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:59:49 INFO - PROCESS | 11285 | console.error: PushService: 10:59:49 INFO - PROCESS | 11285 | stateChangeProcessEnqueue: Error transitioning state 10:59:49 INFO - PROCESS | 11285 | UnknownError 10:59:49 INFO - TEST-INFO | 11285: exit 0 10:59:49 INFO - Browser initialized. 10:59:49 INFO - Running cycle 1/1 for kraken test... 10:59:49 INFO - TEST-INFO | started process 11366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4si7va/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:02 INFO - PROCESS | 11366 | RSS: Main: 174833664 11:00:02 INFO - PROCESS | 11366 | 11:00:04 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-beat-detection) 11:00:05 INFO - PROCESS | 11366 | RSS: Main: 233832448 11:00:05 INFO - PROCESS | 11366 | 11:00:08 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-dft) 11:00:09 INFO - PROCESS | 11366 | RSS: Main: 218488832 11:00:09 INFO - PROCESS | 11366 | 11:00:12 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-fft) 11:00:13 INFO - PROCESS | 11366 | RSS: Main: 300548096 11:00:13 INFO - PROCESS | 11366 | 11:00:15 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-oscillator) 11:00:15 INFO - PROCESS | 11366 | RSS: Main: 209899520 11:00:15 INFO - PROCESS | 11366 | 11:00:18 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:00:18 INFO - PROCESS | 11366 | RSS: Main: 214306816 11:00:18 INFO - PROCESS | 11366 | 11:00:21 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-darkroom) 11:00:22 INFO - PROCESS | 11366 | RSS: Main: 250281984 11:00:22 INFO - PROCESS | 11366 | 11:00:25 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-desaturate) 11:00:26 INFO - PROCESS | 11366 | RSS: Main: 244297728 11:00:26 INFO - PROCESS | 11366 | 11:00:29 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44931/tests/kraken/driver.html?testName=json-parse-financial) 11:00:30 INFO - PROCESS | 11366 | RSS: Main: 247607296 11:00:30 INFO - PROCESS | 11366 | 11:00:31 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:00:32 INFO - PROCESS | 11366 | RSS: Main: 210677760 11:00:32 INFO - PROCESS | 11366 | 11:00:34 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:00:34 INFO - PROCESS | 11366 | RSS: Main: 217886720 11:00:34 INFO - PROCESS | 11366 | 11:00:37 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:00:37 INFO - PROCESS | 11366 | RSS: Main: 222158848 11:00:37 INFO - PROCESS | 11366 | 11:00:40 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:00:41 INFO - PROCESS | 11366 | RSS: Main: 222945280 11:00:41 INFO - PROCESS | 11366 | 11:00:44 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:00:44 INFO - PROCESS | 11366 | RSS: Main: 221597696 11:00:44 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44931/tests/kraken/driver.html?testName=ai-astar) 11:00:46 INFO - PROCESS | 11366 | RSS: Main: 272437248 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | __start_tp_report 11:00:46 INFO - PROCESS | 11366 | _x_x_mozilla_page_load 11:00:46 INFO - PROCESS | 11366 | _x_x_mozilla_page_load_details 11:00:46 INFO - PROCESS | 11366 | |i|pagename|runs| 11:00:46 INFO - PROCESS | 11366 | |0;ai-astar;112;116;118;117;118;119;116;115;116;116 11:00:46 INFO - PROCESS | 11366 | |1;audio-beat-detection;154;124;123;158;132;126;126;127;173;124 11:00:46 INFO - PROCESS | 11366 | |2;audio-dft;160;161;161;164;160;162;163;161;162;162 11:00:46 INFO - PROCESS | 11366 | |3;audio-fft;76;77;76;121;77;78;77;78;96;75 11:00:46 INFO - PROCESS | 11366 | |4;audio-oscillator;85;84;119;85;85;84;114;84;84;111 11:00:46 INFO - PROCESS | 11366 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;116;117;117 11:00:46 INFO - PROCESS | 11366 | |6;imaging-darkroom;147;185;146;146;147;146;146;146;147;147 11:00:46 INFO - PROCESS | 11366 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 11:00:46 INFO - PROCESS | 11366 | |8;json-parse-financial;66;64;64;63;66;66;65;65;66;65 11:00:46 INFO - PROCESS | 11366 | |9;json-stringify-tinderbox;66;66;66;67;67;66;66;66;66;67 11:00:46 INFO - PROCESS | 11366 | |10;stanford-crypto-aes;83;82;82;83;84;81;81;81;81;81 11:00:46 INFO - PROCESS | 11366 | |11;stanford-crypto-ccm;144;142;131;133;131;133;136;142;178;132 11:00:46 INFO - PROCESS | 11366 | |12;stanford-crypto-pbkdf2;177;174;179;172;171;169;176;175;171;168 11:00:46 INFO - PROCESS | 11366 | |13;stanford-crypto-sha256-iterative;74;70;71;68;69;71;71;69;67;68 11:00:46 INFO - PROCESS | 11366 | __end_tp_report 11:00:46 INFO - PROCESS | 11366 | __start_cc_report 11:00:46 INFO - PROCESS | 11366 | _x_x_mozilla_cycle_collect,1979 11:00:46 INFO - PROCESS | 11366 | __end_cc_report 11:00:46 INFO - PROCESS | 11366 | __startTimestamp1474135246878__endTimestamp 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | ------- Summary: start ------- 11:00:46 INFO - PROCESS | 11366 | Number of tests: 14 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.50 stddev:1.95 (1.7%) stddev-sans-first:1.30 11:00:46 INFO - PROCESS | 11366 | Values: 112.0 116.0 118.0 117.0 118.0 119.0 116.0 115.0 116.0 116.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:129.50 stddev:18.03 (13.9%) stddev-sans-first:18.01 11:00:46 INFO - PROCESS | 11366 | Values: 154.0 124.0 123.0 158.0 132.0 126.0 126.0 127.0 173.0 124.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 11:00:46 INFO - PROCESS | 11366 | Values: 160.0 161.0 161.0 164.0 160.0 162.0 163.0 161.0 162.0 162.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:14.65 (19.0%) stddev-sans-first:15.32 11:00:46 INFO - PROCESS | 11366 | Values: 76.0 77.0 76.0 121.0 77.0 78.0 77.0 78.0 96.0 75.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:14.74 (17.5%) stddev-sans-first:15.31 11:00:46 INFO - PROCESS | 11366 | Values: 85.0 84.0 119.0 85.0 85.0 84.0 114.0 84.0 84.0 111.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:00:46 INFO - PROCESS | 11366 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:147.00 stddev:12.20 (8.3%) stddev-sans-first:12.88 11:00:46 INFO - PROCESS | 11366 | Values: 147.0 185.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:00:46 INFO - PROCESS | 11366 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 11:00:46 INFO - PROCESS | 11366 | Values: 66.0 64.0 64.0 63.0 66.0 66.0 65.0 65.0 66.0 65.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:00:46 INFO - PROCESS | 11366 | Values: 66.0 66.0 66.0 67.0 67.0 66.0 66.0 66.0 66.0 67.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 11:00:46 INFO - PROCESS | 11366 | Values: 83.0 82.0 82.0 83.0 84.0 81.0 81.0 81.0 81.0 81.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.00 stddev:14.17 (10.2%) stddev-sans-first:14.96 11:00:46 INFO - PROCESS | 11366 | Values: 144.0 142.0 131.0 133.0 131.0 133.0 136.0 142.0 178.0 132.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.50 stddev:3.58 (2.1%) stddev-sans-first:3.53 11:00:46 INFO - PROCESS | 11366 | Values: 177.0 174.0 179.0 172.0 171.0 169.0 176.0 175.0 171.0 168.0 11:00:46 INFO - PROCESS | 11366 | 11:00:46 INFO - PROCESS | 11366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:2.04 (2.9%) stddev-sans-first:1.50 11:00:46 INFO - PROCESS | 11366 | Values: 74.0 70.0 71.0 68.0 69.0 71.0 71.0 69.0 67.0 68.0 11:00:46 INFO - PROCESS | 11366 | -------- Summary: end -------- 11:00:46 INFO - PROCESS | 11366 | 11:00:48 INFO - TEST-INFO | 11366: exit 0 11:00:48 INFO - TEST-OK | kraken | took 65015ms 11:00:48 INFO - SUITE-END | took 1186s 11:00:48 INFO - Completed test suite (00:19:47) 11:00:48 INFO - javascript benchmark 11:00:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.7388261173887, 2643.616675582042, 2673.438577898641, 2683.0475181310635, 2695.4070104577, 4588.426446694163, 4665.346851440801, 4738.597219236365, 4799.472058073609, 4850.32095506629, 4693.155232058228, 4722.763861806904, 4738.928916066253, 4763.6665433419585, 4784.90430191396, 4379.627731642814, 4392.6266267367155, 4412.095520418323, 4433.911321773563, 4516.570925762064, 4468.932966005496, 4482.8879278017985, 4487.371767952489, 4503.054358584701, 4515.277555591106, 4253.851115210984, 4278.080212754242, 4440.933385999213, 4469.776511174445, 4476.306172543261, 4328.718633288858, 4347.2826983547675, 4373.540778218273, 4391.077873646538, 4446.377507149002, 4341.544137865541, 4350.086481838817, 4353.804078816461, 4353.978230108861, 4396.890077748082, 4733.479317275097, 4770.236762118079, 4776.785044672998, 4780.4741478437345, 4786.401699787527, 5031.748412579356, 5083.389993200803, 5089.41471730752, 5098.337216161913, 5160.535551800319, 5150.819721309736, 5151.098557752378, 5151.484851514856, 5198.662086964373, 5207.6354655174155, 4809.78355973982, 4814.133455977958, 4817.9518204818205, 4818.71087734737, 4874.147024270738, 5041.092603331363, 5078.669886457368, 5083.949160508421, 5274.709890955957, 5275.20871869215, 4885.4870238624435, 4925.827596034122, 4933.6299777516115, 4935.728534930613, 4983.0, 5131.4868513148385, 5139.177731562932, 5170.224466330081, 5177.119889618773, 5182.507661772125, 4958.826441074545, 5009.248612708123, 5010.498950105033, 5072.442031376546, 5132.538071573576, 5049.6465247432325, 5053.620978426633, 5056.570191533688, 5057.266696329085, 5061.974690126526, 4138.544760076389, 4173.269677806372, 4181.498220213533, 4196.223698615766, 4248.086661367821, 3689.0408493791806, 3689.6494832990825, 3690.151265209017, 3735.084904198489, 3736.1220113273357, 4354.325079612665, 4375.081232941118, 4381.956180438155, 4402.141582391467, 4431.290993441034, 4966.15575352191, 5022.271770593316, 5066.265391518209, 5097.6941383517105, 5131.538161565477, 4424.048829501673, 4432.711873728197, 4471.776411179428, 4489.775511224426, 4493.1013797240685, 4539.659525535598, 4544.341070544752, 4544.750038747835, 4546.931796023062, 4606.262997920384, 4664.463586687574, 4701.247800351927, 4817.27740838863, 4870.05034018363, 4880.682755620874, 5142.64001519905, 5159.17453207485, 5178.43037265908, 5179.559737422362, 5242.5281724644965, 4871.8294859679745, 4901.583365413837, 4902.436219834622, 4917.704937703749, 4921.360223170965, 4856.39295088114, 4908.8772780680765, 5035.0, 5052.065367906949, 5053.082132400642, 5058.772355244097, 5103.948960510347, 5114.0, 5132.358455193101, 5183.585313175013, 4971.65198436106, 4972.552470277692, 4974.502549745142, 4975.452700203047, 5036.370453693288, 4774.4509381421585, 4947.480514546065, 4974.726390048582, 4989.60083193351, 5045.62157838171, 4770.379850619397, 4807.086653535817, 4813.302071199727, 4819.783109760139, 4880.46314905353, 4861.6596838220985, 4882.487338829372, 4894.14352488306, 4923.236898280772, 4926.088673595396, 4749.976250118727, 4786.569208771228, 4800.207965685623, 4838.443578988461, 4841.757912104451], "value": 4669.618204337845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3408911573462, 570.1476292942051, 574.971251437428, 589.3487696095814, 594.5778497266939, 27571.862140689293, 29894.1031769047, 29916.70083299169, 40983.59016409835, 42256.0, 39916.40125398121, 40288.59711402885, 40303.79848100755, 40322.7983860081, 40343.39484907729, 7472.065991751031, 7660.348870346, 7668.309852113309, 7668.309852113309, 7668.616569171547, 7403.518771279876, 7504.887426688577, 7506.3861269826975, 7509.586972716498, 7512.9624351878165, 7502.137254215753, 7528.096628404599, 7546.320831125197, 7546.396288296951, 7550.735724249653, 7447.88828167578, 7497.212792656802, 7504.437167212481, 7504.699812007513, 7514.549127052394, 5485.396606373296, 5534.75093620788, 5538.196961440569, 5538.224648549206, 5539.944600553983, 36573.268534629424, 36743.26513469742, 36763.448548271794, 36872.44691329632, 36881.81559092214, 2731.7951153663553, 2769.5568709006666, 2770.7783377329965, 2773.4037182005964, 2877.4820532304175, 27420.451590968267, 27843.582346264822, 27965.44069118606, 28191.295217619518, 28503.714962850314, 3100.8442451775013, 3105.3013072058607, 3124.218945263684, 3154.9053528394184, 3214.694604012615, 238685.0, 240952.79523602445, 241568.0, 241961.95095122588, 242446.99999999822, 49263.75368123208, 49286.75356623194, 49655.0, 49677.751611242435, 49746.25380619294, 31586.36827263442, 32714.182145446553, 32728.0, 51821.48178518242, 52293.47706522962, 12541.184822986477, 12855.1001429899, 12860.807087893689, 12861.228326300452, 12868.678283042998, 9391.859122113037, 9422.623095076257, 9433.76415589602, 9434.716958491255, 9445.433274003582, 17342.393016244623, 17378.47864564065, 17413.0, 17536.47390578285, 17576.736348954775, 6404.967975160094, 6522.771702990372, 6597.977313516412, 6635.535512514174, 6696.59820410777, 731.7365748330596, 778.5250996891891, 799.9840003199903, 856.4903882190087, 919.2921450483091, 27754.444911101666, 28007.71992280092, 28095.0, 28163.577546336823, 28578.0, 860.655737704923, 876.68001179569, 878.1262643669589, 893.8659201119884, 905.8867641544807, 13982.300884955712, 14745.77881331781, 14853.897317091441, 14902.925485372503, 15091.169985650675, 363644.0, 406680.0, 415155.0, 680151.0, 681526.0, 48554.27168592474, 49131.263031054565, 49171.262431063566, 49209.0, 49287.75356123196, 1102.8676558812995, 1109.439732934879, 1121.7532142928542, 1125.1224045244721, 1125.4147843121696, 26993.59509607397, 27683.0, 27887.302817429725, 28804.711952880203, 29009.7099029007, 40166.0, 40698.79650601728, 40729.796351018056, 40838.79580602078, 40896.0, 265331.0, 266350.0, 267572.0, 268203.0, 268256.0, 24520.877395612908, 24891.626625600267, 24901.0, 24909.0, 24930.252092437255, 39571.406428903014, 39602.207955840146, 39778.80110599429, 39964.40053399259, 41290.38064428976, 34295.31409371749, 34506.0, 34563.82718086393, 34728.826355868056, 34919.0, 33390.83304583462, 34071.82964085263, 34355.65644343525, 34477.82761086279, 35199.47200792041, 27336.589951151145, 28925.276868078465, 33990.0, 34075.82962085273, 34186.14534636654, 25086.874565627055, 29393.412131756817, 31542.842285789342, 31791.682083178872, 31794.68205317917, 21822.672659910433, 22398.888005559867, 22939.426514336606, 23000.309990700305, 23180.18869339565], "value": 16405.346477135034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.31934999426215, 332.28061247399364, 358.15654134513227, 358.45872732174416, 365.9158393569479, 10681.626143084985, 14458.349374278156, 15170.772438413418, 15926.362945482168, 16778.496645100637, 13800.0, 13991.370388332523, 16266.268017939192, 17056.914715426406, 17215.397461088865, 3977.1449138435305, 4147.771872547009, 4149.9792501037455, 4156.480439945007, 4178.665706743468, 4900.950990490103, 5004.149294619905, 5007.974960125212, 5010.0, 5010.774515146809, 4978.626603004771, 4980.452150263468, 4988.426330971948, 4989.10196164692, 5005.174146265862, 4753.857384278477, 4897.118518666621, 4919.631027672939, 4924.901501969976, 4927.014597080562, 4388.385626012361, 4391.253486907233, 4391.341298805173, 4392.0776636906285, 4394.318880573516, 18651.626967460576, 19462.610747785107, 19702.507437314038, 19743.308984185485, 19772.20911163552, 1752.2377765671974, 2217.9778202218095, 2268.5236100418933, 2270.7729227077325, 2300.0799680127916, 8827.073157318453, 8930.508822014786, 9189.862152067724, 9213.170814626648, 9784.461854597994, 1767.6553072150807, 1800.2349001674368, 1833.7249412588085, 1855.9164837582207, 1901.1349835824806, 63495.365046349405, 65953.34046659568, 66061.33938660599, 67405.3259467404, 68104.6594767023, 9322.394044387092, 9585.0, 9746.707598772047, 9873.851892221479, 10075.496225188712, 11773.764524709457, 12288.508459661693, 25751.227463176136, 27140.45719085647, 27267.590986135223, 8028.678852845937, 8174.9182508175345, 8312.168783121639, 8505.48967061966, 8623.741287761377, 6553.0170474429215, 6682.966585167043, 6718.294579069225, 6911.654417279216, 7055.1886533049355, 6948.456287293416, 7259.564426134449, 7588.506747061423, 7991.640376183086, 8305.418620696613, 3229.434848901433, 3253.3330667213163, 3254.7884387514737, 3266.738660907122, 3307.68576985186, 343.48820257816175, 344.04698983814694, 748.330244431231, 783.0994356490082, 907.7004588485784, 9320.533973301443, 10076.0, 10277.17782577407, 10341.896581034243, 10422.739431514272, 377.25303898281555, 378.6459660217705, 381.967532759713, 388.3611459149739, 400.1656546101353, 5081.526357356325, 5270.789168433296, 5354.518093371616, 5532.3637781655625, 5662.17898404729, 356894.0, 363248.0, 375270.0, 398256.0, 408192.0, 81935.59032204801, 81965.0, 83204.58397707973, 83509.0, 83526.0, 405.4404921208772, 413.4022004950903, 414.6641220611314, 414.7428594271571, 415.4640513737245, 9485.905140948502, 9512.33413661037, 9583.185429238314, 9589.424634521672, 9598.95200523993, 28458.57312140361, 35053.443052403025, 35113.47329790004, 36199.27601447904, 37238.6276137246, 48402.0, 48663.75668121778, 48853.51146488632, 49346.0, 49503.75248123737, 7137.2149063604, 7151.141862976476, 7342.229065947999, 7517.774466766005, 7581.772546823604, 6031.728572214173, 10632.255742098288, 10829.945850270698, 10851.620193293196, 11133.109351251718, 9670.323077384797, 9762.46306453152, 9983.650572229937, 10045.196384289093, 10502.579896804347, 10249.9487502562, 10318.587256509656, 10346.32748871321, 10379.429131397543, 10393.688189354332, 10302.475893405865, 10464.37213767146, 10562.947185264333, 10860.239783215098, 10860.565577376816, 7125.218695326168, 7406.444516661164, 7464.552126872405, 7652.73215437457, 7761.92238077612, 9893.505324733878, 10098.545565449425, 10167.644132455329, 10359.171266298828, 10548.367097974146], "value": 7543.40202436315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.7556602028626, 1347.8449978252502, 1360.4354193009895, 1585.9303608790524, 1625.439223467904, 6595.7031933562985, 6879.5872247665175, 7076.575405475669, 7626.428017898659, 7626.809329766758, 7048.647567621611, 7390.2609739026075, 7400.925990740091, 7503.962480187605, 7550.848983020336, 2086.551391450838, 2116.0689296709475, 2117.5553133841913, 2142.882141482218, 2145.0883374565824, 1706.940257091002, 2067.8345732341377, 2111.166089394696, 2140.464883779055, 2146.1737231166035, 1824.1700026487915, 2011.0749055434444, 2072.533679922013, 2079.7088407622946, 2080.178329559823, 2071.85497015209, 2072.554400803827, 2075.533005073854, 2076.9792302076935, 2081.2715549557684, 2050.6513892638286, 2083.5312054787705, 2086.634838903201, 2088.6553718636405, 2094.0786054136283, 7620.61896905158, 7669.38644908406, 7679.0, 7687.077550693896, 7687.192844751333, 4133.524644665872, 4251.744895306291, 4253.425787518676, 4253.425787518676, 4281.336392859112, 2674.652295201611, 2783.0815830775796, 2795.594638777386, 2814.788890833175, 2817.3377707152877, 866.1814585216972, 895.9148880856374, 915.5513798238882, 919.2508105893676, 921.1019256225194, 10249.436281004542, 10253.949210157998, 10303.845442318372, 10307.12389446898, 10315.226358023103, 3781.8487260509823, 3916.921661566753, 4041.0, 4103.958960410418, 4104.630583247463, 8779.429337093195, 8808.383413161017, 8809.911900881038, 8823.205911467998, 8843.204111629984, 4254.170436764801, 4276.080642661843, 4288.52826189119, 4292.141571685675, 4300.075483771005, 3949.822257998397, 3963.8810835674976, 3971.5035620547433, 3979.2041591681777, 3981.5819338969573, 3259.2992506611195, 3380.4253276942977, 3387.441072223105, 3402.9829850851083, 3432.090496018557, 928.8281667891462, 994.1400688404478, 1005.0552480668294, 1008.047395211518, 1028.2236911132047, 543.7444401131462, 660.1582981698277, 665.7237246542727, 691.0843132848995, 691.3017851969446, 4696.38946936896, 4741.786619602126, 4850.223964165787, 4879.878003049881, 4921.557059864558, 796.5977181523293, 822.5845947796444, 837.8031162676766, 844.5558095656373, 855.4354126276752, 3224.4840825467813, 3269.411505928908, 3314.121757734202, 3326.916827079294, 3542.132177616449, 9040.593173307218, 9486.146246837818, 9499.477528735986, 9500.23998080152, 9502.47736374506, 9418.670346537838, 9455.52722363879, 9479.620815167455, 9536.713898583053, 9539.666111686058, 7095.467839912028, 7240.1311842579225, 7250.673719682627, 7254.637268136677, 7260.128784545783, 4995.975020124876, 5174.560162386239, 5263.947360526499, 5291.550218231493, 5425.945740542702, 8418.494890306602, 8542.18849209324, 8571.314294856522, 8581.528015959182, 8587.484750914966, 8369.790755231168, 8489.915100848912, 8569.65721371163, 8625.913740862761, 8845.380823342304, 6339.683015849281, 6503.317151699003, 6523.282438931618, 6527.934720652733, 6541.771038013647, 6818.8636227276165, 6872.072270243653, 6875.724971001104, 6879.862402752017, 6884.793456196322, 5809.564282678732, 5994.940050599438, 6099.8780024398375, 6129.049997250433, 6175.7838475654935, 5986.431289027535, 6110.114033465212, 6119.816405507842, 6128.203333566607, 6145.661988590492, 5770.826875193751, 5794.0, 5795.681237531976, 5799.159121927212, 5875.823725288248, 4374.922284946931, 4430.357598148186, 4444.977775111104, 4480.977595112004, 4593.402857628487, 4339.934900976551, 4445.133199026159, 4449.17690227309, 4456.554344565518, 4461.8622251325705], "value": 3903.2238011771365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.308127790109, 294.47142379428925, 296.68995899285244, 303.96352437707463, 305.5203330770691, 4934.506549345068, 4948.253719185859, 4956.132676781558, 4969.826056088038, 4980.352554167957, 4838.685485443444, 4875.122477953967, 4902.926456103161, 4902.940764878751, 4911.80352785889, 3606.5311509503726, 3699.6855267302312, 3700.481932529448, 3767.60440153784, 3802.6007269236748, 3803.8288277027464, 3809.619038096182, 3810.047488127968, 3810.428435734634, 3832.693384529245, 3752.906177345561, 3779.2063666630042, 3781.054736315921, 3797.2405518896194, 3806.7525610835346, 3635.6548077211337, 3641.8725344612812, 3739.8317075731657, 3756.267527832074, 3811.5235595550557, 3327.7670563060597, 3333.3833240850277, 3335.699077359832, 3337.466005439118, 3352.932941341184, 4715.434147902273, 4724.913269947897, 4735.526447355237, 4740.312654665055, 4750.501197374295, 4190.769507677077, 4351.434313539251, 4351.543087975749, 4364.236258654722, 4382.496012958519, 5056.620753443506, 5071.1632580624155, 5073.239014147871, 5079.6698214615935, 5088.821891233826, 3662.8351724172476, 3671.963280367189, 3685.4287585424304, 3687.7049836013052, 3694.18727879866, 5151.304573882516, 5291.603129765283, 5327.227552004976, 5338.225957236179, 5380.273663055476, 3743.9438408423352, 3755.286495565834, 3755.868544600926, 3758.2107757370713, 3771.641694039062, 3800.7529510582276, 3820.598837122118, 3833.3483307837732, 3836.3478208704587, 3838.405047217686, 4324.0919406924895, 4366.476022877211, 4368.104538569585, 4371.650267978554, 4372.715773474714, 4814.301926220678, 5100.1074811907765, 5111.386633603991, 5135.6918584885025, 5146.305248791366, 1320.735852829438, 1342.1745626439865, 1342.89256859451, 1344.327836081959, 1348.5347555093476, 811.9472234304869, 843.7510934274404, 875.8773771671971, 887.2148148888281, 890.2966656341417, 4376.190404775063, 4405.361222622766, 4496.527864574238, 4541.273396256649, 4556.476005259371, 5234.398044224887, 5238.371395432572, 5247.344081989751, 5251.238570407269, 5271.077561426811, 4543.318502224693, 4550.292575917324, 4564.954350456519, 4580.312953057001, 4581.702189357681, 2660.2152365052357, 2765.5160346939206, 2782.664321125871, 2786.8327900326044, 2787.958180627292, 4956.776945037482, 4962.925556116661, 4972.154733695208, 4979.925301120486, 4999.700077979679, 5147.485251474897, 5368.436314187033, 5369.69763595386, 5378.811741589026, 5395.514403703685, 4924.227278179852, 4953.356063711694, 4965.4041515018425, 4974.303597496353, 4979.30289759434, 5195.76619052136, 5211.9478805212975, 5213.218017297284, 5238.738063096906, 5243.265942767939, 4999.975000124976, 5135.820246291362, 5143.382794064587, 5159.380874295109, 5169.147090730138, 4948.406191257072, 4950.801967921243, 4952.8761780955765, 4963.801447942042, 4964.925526117184, 3725.7950812704476, 3733.5706393765063, 3751.230997645531, 3770.8114594269628, 3774.245150969762, 5121.4661883300405, 5162.716050617252, 5270.657407268515, 5274.551663108526, 5296.311479507639, 5057.14028615129, 5068.214426763858, 5073.34046573943, 5077.492250775041, 5106.157484015096, 4969.229769385751, 5085.821996230115, 5092.567131793691, 5105.846824595268, 5132.0, 4724.763761811964, 4984.0, 5009.173486374707, 5025.84922452327, 5047.520485553867, 4800.0, 4937.876553086058, 4977.178765503651, 5033.773480193327, 5078.669886457368, 4977.701337919736, 4984.127777638826, 5019.749012549285, 5030.270610761492, 5035.949640503548], "value": 3845.5773108408484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.494980633942, 560.6551970538119, 571.5656101362965, 600.0938582740063, 615.3508049008294, 11471.713207169814, 11952.820707689392, 12066.215695979756, 12103.455344509497, 12105.818412723816, 12248.632541023784, 12410.751784964295, 12411.317377544232, 12432.44054017569, 12600.369981500911, 585.066818424612, 724.7282269149069, 743.8400743840074, 745.7986343687202, 746.6789280609336, 605.6033298189693, 612.8130920069377, 613.9938600614004, 717.7057406463351, 746.0711414289218, 790.1782146567563, 792.6987744657022, 792.8097256658418, 792.8295416485455, 793.0404210904812, 786.6381464526324, 786.9960650196713, 787.0437418536477, 787.086979104242, 787.6022608582658, 452.69669321554636, 460.56016504238374, 463.11776066593194, 577.3216470647016, 577.7053702611656, 9718.70843874685, 11810.88189118115, 12271.0, 12290.938545307306, 12351.567695130718, 11874.228175168586, 13088.672783180402, 13119.409626566732, 13485.460581576725, 13628.114172578751, 12001.63995080149, 12032.27806331623, 12253.387330633434, 12255.877441225563, 13173.209607423489, 4084.7957602119777, 4154.480689913761, 4213.51544572375, 4214.115035842477, 4214.662826973866, 62165.6891715543, 62411.0, 62558.68720656368, 63424.04863927045, 63776.681116594584, 10297.330673506198, 10584.629537966135, 10635.617369741884, 10771.892281077246, 11098.889011109786, 19105.331313403964, 19187.90406047961, 19262.13320400557, 19315.710264346046, 19668.311609093613, 6673.1992160941, 6704.932950670528, 6718.865622687616, 6851.520393572402, 6976.7558135465015, 3475.6350583188905, 3575.481555174485, 3600.225951420457, 3729.8321575529167, 3802.733808633369, 2548.13363456422, 2587.1333103410193, 2607.752263534961, 2609.6868375795025, 2610.6084087387044, 455.24883941496796, 461.1284671969979, 464.45194670289385, 468.8335640847518, 475.2135216217166, 383.48995835538665, 443.07397539142704, 452.60623257765957, 457.0630208073436, 480.64912613792126, 6986.196587392414, 7156.570605763567, 7162.534435261691, 7333.633318334062, 7472.85054298911, 458.20730136863415, 464.7304563353247, 469.7533794757711, 470.85168172025703, 479.8848276413636, 3463.255400088993, 3517.6306487818924, 3572.481990111471, 3662.9052480745036, 3665.6700896918874, 74747.0, 76097.61951190208, 100380.0, 105851.47074264579, 106062.46968765107, 47429.0, 47655.0, 47959.04081918342, 48719.5128048722, 74073.0, 55025.44974550203, 68017.3198268021, 71282.2871771286, 73703.6314818444, 75971.86042209371, 7729.955951536828, 7955.920440795518, 8195.754127376189, 8219.506829590004, 8514.0, 44730.329045065, 44822.3276650844, 46042.53957460383, 46488.767556162005, 46920.29619555778, 55386.0, 65969.0, 65984.03071861874, 66121.66939165466, 66896.0, 10462.529186186488, 10566.735831604272, 10679.359238445719, 10962.56149754001, 10997.12023038171, 11507.42462876836, 11557.47991340375, 11748.941255293668, 12162.148649594443, 12219.877801221874, 11651.825222621837, 11799.115066369885, 12233.571824986082, 12411.441485133371, 12628.11603187768, 11478.885211148116, 11652.53389864396, 12115.394230288626, 12334.50661973511, 12458.127931044739, 11055.889441105486, 11178.119848806884, 11404.771904562029, 11667.299962002307, 11863.644090677293, 9133.588988495667, 9444.811103777749, 9841.803163936538, 9876.111149996535, 10068.395896245956, 9623.807523849624, 10013.741411617739, 10068.44623545712, 10136.391816491034, 10205.897941020792], "value": 6204.5604890378645, "unit": "score"}], "name": "dromaeo_css", "value": 6144.636589797647, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 118.0, 117.0, 118.0, 119.0, 116.0, 115.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 123.0, 158.0, 132.0, 126.0, 126.0, 127.0, 173.0, 124.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 164.0, 160.0, 162.0, 163.0, 161.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 121.0, 77.0, 78.0, 77.0, 78.0, 96.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 85.0, 85.0, 84.0, 114.0, 84.0, 84.0, 111.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 185.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 84.0, 81.0, 81.0, 81.0, 81.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 131.0, 133.0, 131.0, 133.0, 136.0, 142.0, 178.0, 132.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 179.0, 172.0, 171.0, 169.0, 176.0, 175.0, 171.0, 168.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 71.0, 68.0, 69.0, 71.0, 71.0, 69.0, 67.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1550.0000000000002, "alertThreshold": 2.0}]} 11:00:48 INFO - Return code: 0 11:00:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:00:48 INFO - # TBPL SUCCESS # 11:00:48 INFO - Running post-action listener: _resource_record_post_action 11:00:48 INFO - [mozharness: 2016-09-17 18:00:48.693884Z] Finished run-tests step (success) 11:00:48 INFO - Running post-run listener: _resource_record_post_run 11:00:48 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 406007808; Read time: 0; Write time: 289360 11:00:48 INFO - TinderboxPrint: CPU usage
13.1% 11:00:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:00:48 INFO - TinderboxPrint: I/O write bytes / time
406,007,808 / 289,360 11:00:48 INFO - TinderboxPrint: CPU idle
8,341.8 (86.9%) 11:00:48 INFO - TinderboxPrint: CPU user
1,203.7 (12.5%) 11:00:48 INFO - TinderboxPrint: Swap in / out
0 / 0 11:00:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111656960; Read time: 0; Write time: 78800 11:00:48 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290435072; Read time: 0; Write time: 209784 11:00:49 INFO - Running post-run listener: _upload_blobber_files 11:00:49 INFO - Blob upload gear active. 11:00:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:00: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 11:00: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'] 11:00: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 11:00:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:53 INFO - (blobuploader) - INFO - Done attempting. 11:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:54 INFO - (blobuploader) - INFO - Done attempting. 11:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:55 INFO - (blobuploader) - INFO - Done attempting. 11:00:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:00:55 INFO - Return code: 0 11:00:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:00:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:00:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76748774ade1e9dfdf248fe6fd629add3f8d7f0b9d8da78f9f0767c6166eedbee4cef6badc56ba55d530e49c03360fd17fd4fcd60cf9fb8fab9ca671f9efef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/694d7fe89e2c4a9d079064b682c4e5c1eef252564ed82b1e1c37cc38304223dc5e5caf3b03960250843eba5e94dd2a25c19bc5b1bc0e012ffa666791b9a59937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87e01e0496d931f16698208b71a912421eb9ddab50765d070a59d574af82d5bc58f46458a561c7aed2e11a7e43ab46a3a441c94715ed4ce0834ab56d318cc32f"} 11:00:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:00:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:00:55 INFO - Contents: 11:00:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76748774ade1e9dfdf248fe6fd629add3f8d7f0b9d8da78f9f0767c6166eedbee4cef6badc56ba55d530e49c03360fd17fd4fcd60cf9fb8fab9ca671f9efef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/694d7fe89e2c4a9d079064b682c4e5c1eef252564ed82b1e1c37cc38304223dc5e5caf3b03960250843eba5e94dd2a25c19bc5b1bc0e012ffa666791b9a59937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87e01e0496d931f16698208b71a912421eb9ddab50765d070a59d574af82d5bc58f46458a561c7aed2e11a7e43ab46a3a441c94715ed4ce0834ab56d318cc32f"} 11:00:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:00:55 INFO - Copying logs to upload dir... 11:00:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:00:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.516094 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-17 11:00:54.944831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 11:00:54.948106) ========= 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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 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/76748774ade1e9dfdf248fe6fd629add3f8d7f0b9d8da78f9f0767c6166eedbee4cef6badc56ba55d530e49c03360fd17fd4fcd60cf9fb8fab9ca671f9efef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/694d7fe89e2c4a9d079064b682c4e5c1eef252564ed82b1e1c37cc38304223dc5e5caf3b03960250843eba5e94dd2a25c19bc5b1bc0e012ffa666791b9a59937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87e01e0496d931f16698208b71a912421eb9ddab50765d070a59d574af82d5bc58f46458a561c7aed2e11a7e43ab46a3a441c94715ed4ce0834ab56d318cc32f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64/1474061778/firefox-51.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/76748774ade1e9dfdf248fe6fd629add3f8d7f0b9d8da78f9f0767c6166eedbee4cef6badc56ba55d530e49c03360fd17fd4fcd60cf9fb8fab9ca671f9efef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/694d7fe89e2c4a9d079064b682c4e5c1eef252564ed82b1e1c37cc38304223dc5e5caf3b03960250843eba5e94dd2a25c19bc5b1bc0e012ffa666791b9a59937", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87e01e0496d931f16698208b71a912421eb9ddab50765d070a59d574af82d5bc58f46458a561c7aed2e11a7e43ab46a3a441c94715ed4ce0834ab56d318cc32f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 11:00:54.973416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 11:00:54.973749) ========= 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=8887e36bb8e381bfd44124ac000001a8-1474134009.822894-1640604351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 11:00:55.058608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 11:00:55.058926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 11:00:55.059220) ========= ========= Total master_lag: 0.16 =========