builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1474134095.55 results: success (0) buildid: 20160917074612 builduid: 7bae443d5d524323a85c1a2cebeb7ecd revision: f2fe5345c13ff5ec70dc259d653298a7cac61423 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.551201) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.551938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.552281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.567971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.568707) ========= 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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 10:41:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.9M=0s 2016-09-17 10:41:35 (89.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.695084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.695442) ========= 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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014261 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:35.744923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 10:41:35.745316) ========= 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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 10:41:35,991 truncating revision to first 12 chars 2016-09-17 10:41:35,992 Setting DEBUG logging. 2016-09-17 10:41:35,992 attempt 1/10 2016-09-17 10:41:35,992 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:41:36,631 unpacking tar archive at: fx-team-f2fe5345c13f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 10:41:36.760288) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:36.760784) ========= script_repo_revision: f2fe5345c13ff5ec70dc259d653298a7cac61423 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:36.761582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:36.762344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 10:41:36.774217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-17 10:41:36.774537) ========= /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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:41:37 INFO - MultiFileLogger online at 20160917 10:41:37 in /builds/slave/test 10:41:37 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:41:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:41:37 INFO - {'append_to_log': False, 10:41:37 INFO - 'base_work_dir': '/builds/slave/test', 10:41:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:41:37 INFO - 'branch': 'Fx-Team-Non-PGO', 10:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:41:37 INFO - 'config_files': ('talos/linux_config.py',), 10:41:37 INFO - 'default_actions': ('clobber', 10:41:37 INFO - 'read-buildbot-config', 10:41:37 INFO - 'download-and-extract', 10:41:37 INFO - 'populate-webroot', 10:41:37 INFO - 'create-virtualenv', 10:41:37 INFO - 'install', 10:41:37 INFO - 'run-tests'), 10:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:41:37 INFO - 'download_minidump_stackwalk': True, 10:41:37 INFO - 'download_symbols': 'ondemand', 10:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:41:37 INFO - 'installer_path': 'installer.exe', 10:41:37 INFO - 'log_level': 'info', 10:41:37 INFO - 'log_name': 'talos', 10:41:37 INFO - 'log_to_console': True, 10:41:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:41:37 INFO - 'opt_config_files': (), 10:41:37 INFO - 'pip_index': False, 10:41:37 INFO - 'sps_profile': False, 10:41:37 INFO - 'sps_profile_interval': 0, 10:41:37 INFO - 'suite': 'dromaeojs', 10:41:37 INFO - 'system_bits': '32', 10:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:41:37 INFO - 'title': 'talos-linux64-ix-007', 10:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:41:37 INFO - 'use_talos_json': True, 10:41:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:41:37 INFO - 'work_dir': 'build'} 10:41:37 INFO - [mozharness: 2016-09-17 17:41:37.121730Z] Running clobber step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: clobber 10:41:37 INFO - rmtree: /builds/slave/test/build 10:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:41:37 INFO - Running post-action listener: _resource_record_post_action 10:41:37 INFO - [mozharness: 2016-09-17 17:41:37.581653Z] Finished clobber step (success) 10:41:37 INFO - [mozharness: 2016-09-17 17:41:37.581753Z] Running read-buildbot-config step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: read_buildbot_config 10:41:37 INFO - Using buildbot properties: 10:41:37 INFO - { 10:41:37 INFO - "project": "", 10:41:37 INFO - "product": "firefox", 10:41:37 INFO - "script_repo_revision": "production", 10:41:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:41:37 INFO - "repository": "", 10:41:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:41:37 INFO - "buildid": "20160917074612", 10:41:37 INFO - "stage_platform": "linux64", 10:41:37 INFO - "basedir": "/builds/slave/test", 10:41:37 INFO - "buildnumber": 3324, 10:41:37 INFO - "platform": "ubuntu64_hw", 10:41:37 INFO - "mozci_request": { 10:41:37 INFO - "priority": -1, 10:41:37 INFO - "type": "trigger_all_talos_jobs", 10:41:37 INFO - "times": 6 10:41:37 INFO - }, 10:41:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:41:37 INFO - "slavebuilddir": "test", 10:41:37 INFO - "branch": "fx-team", 10:41:37 INFO - "revision": "f2fe5345c13ff5ec70dc259d653298a7cac61423", 10:41:37 INFO - "slavename": "talos-linux64-ix-007", 10:41:37 INFO - "builduid": "7bae443d5d524323a85c1a2cebeb7ecd", 10:41:37 INFO - "repo_path": "integration/fx-team" 10:41:37 INFO - } 10:41:37 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:41:37 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:41:37 INFO - Running post-action listener: _resource_record_post_action 10:41:37 INFO - [mozharness: 2016-09-17 17:41:37.584514Z] Finished read-buildbot-config step (success) 10:41:37 INFO - [mozharness: 2016-09-17 17:41:37.584604Z] Running download-and-extract step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: download_and_extract 10:41:37 INFO - mkdir: /builds/slave/test/build/tests 10:41: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:41:37 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:41:37 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:41:37 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:41:37 INFO - Downloaded 1361 bytes. 10:41:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:41:37 INFO - Using the following test package requirements: 10:41:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:41:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:41:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:41:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'jsshell-linux-x86_64.zip'], 10:41:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:41:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:41:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:41:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:41:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:41:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:41:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:41:37 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:41:37 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:41:37 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:41:37 INFO - Expected file size: 20365791 10:41:41 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:41:41 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:41:41 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:41:41 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:41:41 INFO - Expected file size: 20365791 10:41:46 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:41:46 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:41:46 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:41:46 INFO - Expected file size: 14414048 10:41:46 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:46 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:41:46 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:41:46 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:41:47 INFO - Downloaded 55593420 bytes. 10:41:47 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:41:47 INFO - mkdir: /builds/slave/test/properties 10:41:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:41:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:41:47 INFO - Contents: 10:41:47 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:41:48 INFO - Running post-action listener: _resource_record_post_action 10:41:48 INFO - Running post-action listener: set_extra_try_arguments 10:41:48 INFO - [mozharness: 2016-09-17 17:41:48.255793Z] Finished download-and-extract step (success) 10:41:48 INFO - [mozharness: 2016-09-17 17:41:48.256021Z] Running populate-webroot step. 10:41:48 INFO - Running pre-action listener: _resource_record_pre_action 10:41:48 INFO - Running main action method: populate_webroot 10:41:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:41:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:41:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:41:48 INFO - '--tppagecycles', 10:41:48 INFO - '7'], 10:41:48 INFO - 'tests': ['tsvgm']}}, 10:41:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:41:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:41:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:41:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:41:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:41:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:41:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['damp', 'tps']}, 10:41:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'tests': ['damp', 'tps']}, 10:41:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['dromaeo_dom']}, 10:41:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:41:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['basic_compositor_video']}, 10:41:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:41:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['a11yr', 10:41:48 INFO - 'ts_paint', 10:41:48 INFO - 'tpaint', 10:41:48 INFO - 'sessionrestore', 10:41:48 INFO - 'sessionrestore_no_auto_restore', 10:41:48 INFO - 'tabpaint']}, 10:41:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['tsvgx', 10:41:48 INFO - 'tsvgr_opacity', 10:41:48 INFO - 'tart', 10:41:48 INFO - 'tscrollx', 10:41:48 INFO - 'cart']}, 10:41:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:41:48 INFO - 'tsvgr_opacity', 10:41:48 INFO - 'tart', 10:41:48 INFO - 'tscrollx', 10:41:48 INFO - 'cart']}, 10:41:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'talos_options': ['--disable-e10s'], 10:41:48 INFO - 'tests': ['tp5o']}, 10:41:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'tests': ['tp5o']}, 10:41:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'talos_options': ['--disable-e10s', 10:41:48 INFO - '--xperf_path', 10:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:41:48 INFO - 'tests': ['tp5n']}, 10:41:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:48 INFO - 'talos_options': ['--xperf_path', 10:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:41:48 INFO - 'tests': ['tp5n']}}, 10:41:48 INFO - 'talos.zip': {'path': '', 10:41:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:41:48 INFO - Running post-action listener: _resource_record_post_action 10:41:48 INFO - [mozharness: 2016-09-17 17:41:48.278012Z] Finished populate-webroot step (success) 10:41:48 INFO - [mozharness: 2016-09-17 17:41:48.278101Z] Running create-virtualenv step. 10:41:48 INFO - Running pre-action listener: _resource_record_pre_action 10:41:48 INFO - Running main action method: create_virtualenv 10:41:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:41:48 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:41:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:41:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:41:48 INFO - Using real prefix '/usr' 10:41:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:41:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:41:50 INFO - Installing pip.................done. 10:41:50 INFO - Return code: 0 10:41:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:41:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:50 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:50 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:41:50 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:41:50 INFO - Using env: {'DISPLAY': ':0', 10:41:50 INFO - 'HOME': '/home/cltbld', 10:41:50 INFO - 'LANG': 'en_US.UTF-8', 10:41:50 INFO - 'LANGUAGE': 'en_US:en', 10:41:50 INFO - 'LOGNAME': 'cltbld', 10:41:50 INFO - 'MAIL': '/var/mail/cltbld', 10:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:50 INFO - 'MOZ_NO_REMOTE': '1', 10:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:50 INFO - 'NO_EM_RESTART': '1', 10:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:50 INFO - 'PWD': '/builds/slave/test', 10:41:50 INFO - 'SHELL': '/bin/bash', 10:41:50 INFO - 'SHLVL': '1', 10:41:50 INFO - 'TERM': 'linux', 10:41:50 INFO - 'TMOUT': '86400', 10:41:50 INFO - 'USER': 'cltbld', 10:41:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:50 INFO - '_': '/tools/buildbot/bin/python'} 10:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:51 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:41:51 INFO - Cleaning up... 10:41:51 INFO - Return code: 0 10:41:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:41:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:51 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:51 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:41:51 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:41:51 INFO - Using env: {'DISPLAY': ':0', 10:41:51 INFO - 'HOME': '/home/cltbld', 10:41:51 INFO - 'LANG': 'en_US.UTF-8', 10:41:51 INFO - 'LANGUAGE': 'en_US:en', 10:41:51 INFO - 'LOGNAME': 'cltbld', 10:41:51 INFO - 'MAIL': '/var/mail/cltbld', 10:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:51 INFO - 'MOZ_NO_REMOTE': '1', 10:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:51 INFO - 'NO_EM_RESTART': '1', 10:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:51 INFO - 'PWD': '/builds/slave/test', 10:41:51 INFO - 'SHELL': '/bin/bash', 10:41:51 INFO - 'SHLVL': '1', 10:41:51 INFO - 'TERM': 'linux', 10:41:51 INFO - 'TMOUT': '86400', 10:41:51 INFO - 'USER': 'cltbld', 10:41:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:51 INFO - '_': '/tools/buildbot/bin/python'} 10:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:51 INFO - Downloading/unpacking psutil>=3.1.1 10:41:51 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:41:51 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:41:51 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:41:51 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:41:51 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:41:51 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:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:41:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:53 INFO - Installing collected packages: psutil 10:41:53 INFO - Running setup.py install for psutil 10:41:53 INFO - building 'psutil._psutil_linux' extension 10:41:53 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:41:53 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:41:53 INFO - building 'psutil._psutil_posix' extension 10:41:53 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:41:53 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:41:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:53 INFO - Successfully installed psutil 10:41:53 INFO - Cleaning up... 10:41:53 INFO - Return code: 0 10:41:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:53 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:53 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:41:53 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:41:53 INFO - Using env: {'DISPLAY': ':0', 10:41:53 INFO - 'HOME': '/home/cltbld', 10:41:53 INFO - 'LANG': 'en_US.UTF-8', 10:41:53 INFO - 'LANGUAGE': 'en_US:en', 10:41:53 INFO - 'LOGNAME': 'cltbld', 10:41:53 INFO - 'MAIL': '/var/mail/cltbld', 10:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:53 INFO - 'MOZ_NO_REMOTE': '1', 10:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:53 INFO - 'NO_EM_RESTART': '1', 10:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:53 INFO - 'PWD': '/builds/slave/test', 10:41:53 INFO - 'SHELL': '/bin/bash', 10:41:53 INFO - 'SHLVL': '1', 10:41:53 INFO - 'TERM': 'linux', 10:41:53 INFO - 'TMOUT': '86400', 10:41:53 INFO - 'USER': 'cltbld', 10:41:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:53 INFO - '_': '/tools/buildbot/bin/python'} 10:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:41:54 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:41:54 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:41:54 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:41:54 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:41:54 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:41:54 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:41:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:41:56 INFO - Installing collected packages: mozsystemmonitor 10:41:56 INFO - Running setup.py install for mozsystemmonitor 10:41:56 INFO - Successfully installed mozsystemmonitor 10:41:56 INFO - Cleaning up... 10:41:56 INFO - Return code: 0 10:41:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:41:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:56 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:56 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:41:56 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:41:56 INFO - Using env: {'DISPLAY': ':0', 10:41:56 INFO - 'HOME': '/home/cltbld', 10:41:56 INFO - 'LANG': 'en_US.UTF-8', 10:41:56 INFO - 'LANGUAGE': 'en_US:en', 10:41:56 INFO - 'LOGNAME': 'cltbld', 10:41:56 INFO - 'MAIL': '/var/mail/cltbld', 10:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:56 INFO - 'MOZ_NO_REMOTE': '1', 10:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:56 INFO - 'NO_EM_RESTART': '1', 10:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:56 INFO - 'PWD': '/builds/slave/test', 10:41:56 INFO - 'SHELL': '/bin/bash', 10:41:56 INFO - 'SHLVL': '1', 10:41:56 INFO - 'TERM': 'linux', 10:41:56 INFO - 'TMOUT': '86400', 10:41:56 INFO - 'USER': 'cltbld', 10:41:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:56 INFO - '_': '/tools/buildbot/bin/python'} 10:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:56 INFO - Downloading/unpacking jsonschema==2.5.1 10:41:56 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:41:56 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:41:56 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:41:56 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:41:56 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:41:56 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:41:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:41:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:41:58 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:41:58 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:41:58 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:41:58 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:41:58 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:41:58 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:41:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:41:58 INFO - warning: no files found matching '*.txt' 10:41:58 INFO - no previously-included directories found matching 'build' 10:41:58 INFO - no previously-included directories found matching 'dist' 10:41:58 INFO - no previously-included directories found matching '.git*' 10:41:58 INFO - Installing collected packages: jsonschema, functools32 10:41:58 INFO - Running setup.py install for functools32 10:41:58 INFO - warning: no files found matching '*.txt' 10:41:58 INFO - no previously-included directories found matching 'build' 10:41:58 INFO - no previously-included directories found matching 'dist' 10:41:58 INFO - no previously-included directories found matching '.git*' 10:41:58 INFO - Successfully installed jsonschema functools32 10:41:58 INFO - Cleaning up... 10:41:58 INFO - Return code: 0 10:41:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:58 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:41:58 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:41:58 INFO - Using env: {'DISPLAY': ':0', 10:41:58 INFO - 'HOME': '/home/cltbld', 10:41:58 INFO - 'LANG': 'en_US.UTF-8', 10:41:58 INFO - 'LANGUAGE': 'en_US:en', 10:41:58 INFO - 'LOGNAME': 'cltbld', 10:41:58 INFO - 'MAIL': '/var/mail/cltbld', 10:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:58 INFO - 'MOZ_NO_REMOTE': '1', 10:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:58 INFO - 'NO_EM_RESTART': '1', 10:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:58 INFO - 'PWD': '/builds/slave/test', 10:41:58 INFO - 'SHELL': '/bin/bash', 10:41:58 INFO - 'SHLVL': '1', 10:41:58 INFO - 'TERM': 'linux', 10:41:58 INFO - 'TMOUT': '86400', 10:41:58 INFO - 'USER': 'cltbld', 10:41:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:58 INFO - '_': '/tools/buildbot/bin/python'} 10:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:41:58 INFO - Cleaning up... 10:41:58 INFO - Return code: 0 10:41:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:41:58 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:41:58 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:41:58 INFO - Using env: {'DISPLAY': ':0', 10:41:58 INFO - 'HOME': '/home/cltbld', 10:41:58 INFO - 'LANG': 'en_US.UTF-8', 10:41:58 INFO - 'LANGUAGE': 'en_US:en', 10:41:58 INFO - 'LOGNAME': 'cltbld', 10:41:58 INFO - 'MAIL': '/var/mail/cltbld', 10:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:58 INFO - 'MOZ_NO_REMOTE': '1', 10:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:58 INFO - 'NO_EM_RESTART': '1', 10:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:58 INFO - 'PWD': '/builds/slave/test', 10:41:58 INFO - 'SHELL': '/bin/bash', 10:41:58 INFO - 'SHLVL': '1', 10:41:58 INFO - 'TERM': 'linux', 10:41:58 INFO - 'TMOUT': '86400', 10:41:58 INFO - 'USER': 'cltbld', 10:41:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:58 INFO - '_': '/tools/buildbot/bin/python'} 10:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:41:59 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:41:59 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:41:59 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:41:59 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:41:59 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:41:59 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:42:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 INFO - Downloading docopt-0.6.1.tar.gz 10:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:01 INFO - Running setup.py install for blobuploader 10:42:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:02 INFO - Running setup.py install for requests 10:42:02 INFO - Running setup.py install for docopt 10:42:02 INFO - Successfully installed blobuploader requests docopt 10:42:02 INFO - Cleaning up... 10:42:02 INFO - Return code: 0 10:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:02 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:42:02 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:42:02 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:42:02 INFO - Using env: {'DISPLAY': ':0', 10:42:02 INFO - 'HOME': '/home/cltbld', 10:42:02 INFO - 'LANG': 'en_US.UTF-8', 10:42:02 INFO - 'LANGUAGE': 'en_US:en', 10:42:02 INFO - 'LOGNAME': 'cltbld', 10:42:02 INFO - 'MAIL': '/var/mail/cltbld', 10:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:02 INFO - 'MOZ_NO_REMOTE': '1', 10:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:02 INFO - 'NO_EM_RESTART': '1', 10:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:02 INFO - 'PWD': '/builds/slave/test', 10:42:02 INFO - 'SHELL': '/bin/bash', 10:42:02 INFO - 'SHLVL': '1', 10:42:02 INFO - 'TERM': 'linux', 10:42:02 INFO - 'TMOUT': '86400', 10:42:02 INFO - 'USER': 'cltbld', 10:42:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:02 INFO - '_': '/tools/buildbot/bin/python'} 10:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:02 INFO - Running setup.py (path:/tmp/pip-fj9TjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:02 INFO - Running setup.py (path:/tmp/pip-4LMjOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:02 INFO - Running setup.py (path:/tmp/pip-SwQ9rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:02 INFO - Running setup.py (path:/tmp/pip-_waMFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:03 INFO - Running setup.py (path:/tmp/pip-mVz27r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:03 INFO - Running setup.py (path:/tmp/pip-Biq6YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:03 INFO - Running setup.py (path:/tmp/pip-KKJGtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:03 INFO - Running setup.py (path:/tmp/pip-O16p_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:03 INFO - Running setup.py (path:/tmp/pip-7Nh_2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:03 INFO - Running setup.py (path:/tmp/pip-4q7T1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:03 INFO - Running setup.py (path:/tmp/pip-D_XfOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:03 INFO - Running setup.py (path:/tmp/pip-f7v9rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:03 INFO - Running setup.py (path:/tmp/pip-SfWeyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:03 INFO - Running setup.py (path:/tmp/pip-lH8WMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:03 INFO - Running setup.py (path:/tmp/pip-Ehp7SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:03 INFO - Running setup.py (path:/tmp/pip-4qno4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:03 INFO - Running setup.py (path:/tmp/pip-A0L5LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:03 INFO - Running setup.py install for manifestparser 10:42:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for mozcrash 10:42:04 INFO - Running setup.py install for mozdebug 10:42:04 INFO - Running setup.py install for mozdevice 10:42:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for mozfile 10:42:04 INFO - Running setup.py install for mozhttpd 10:42:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for mozinfo 10:42:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for mozInstall 10:42:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for mozleak 10:42:04 INFO - Running setup.py install for mozlog 10:42:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:04 INFO - Running setup.py install for moznetwork 10:42:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Running setup.py install for mozprocess 10:42:05 INFO - Running setup.py install for mozprofile 10:42:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Running setup.py install for mozrunner 10:42:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Running setup.py install for mozscreenshot 10:42:05 INFO - Running setup.py install for moztest 10:42:05 INFO - Running setup.py install for mozversion 10:42:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:05 INFO - Cleaning up... 10:42:05 INFO - Return code: 0 10:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:05 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:42:05 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:42:05 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:42:05 INFO - Using env: {'DISPLAY': ':0', 10:42:05 INFO - 'HOME': '/home/cltbld', 10:42:05 INFO - 'LANG': 'en_US.UTF-8', 10:42:05 INFO - 'LANGUAGE': 'en_US:en', 10:42:05 INFO - 'LOGNAME': 'cltbld', 10:42:05 INFO - 'MAIL': '/var/mail/cltbld', 10:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:05 INFO - 'MOZ_NO_REMOTE': '1', 10:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:05 INFO - 'NO_EM_RESTART': '1', 10:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:05 INFO - 'PWD': '/builds/slave/test', 10:42:05 INFO - 'SHELL': '/bin/bash', 10:42:05 INFO - 'SHLVL': '1', 10:42:05 INFO - 'TERM': 'linux', 10:42:05 INFO - 'TMOUT': '86400', 10:42:05 INFO - 'USER': 'cltbld', 10:42:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:05 INFO - '_': '/tools/buildbot/bin/python'} 10:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:05 INFO - Running setup.py (path:/tmp/pip-WDTVzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:06 INFO - Running setup.py (path:/tmp/pip-0EnRBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:06 INFO - Running setup.py (path:/tmp/pip-lcoVle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:06 INFO - Running setup.py (path:/tmp/pip-ZD8uj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:06 INFO - Running setup.py (path:/tmp/pip-SZZjlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:06 INFO - Running setup.py (path:/tmp/pip-FfWvVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:06 INFO - Running setup.py (path:/tmp/pip-xZBEKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:06 INFO - Running setup.py (path:/tmp/pip-BfN6Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:06 INFO - Running setup.py (path:/tmp/pip-2PW46f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:06 INFO - Running setup.py (path:/tmp/pip-7IPnpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:06 INFO - Running setup.py (path:/tmp/pip-j1fUQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:06 INFO - Running setup.py (path:/tmp/pip-i2_JxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:06 INFO - Running setup.py (path:/tmp/pip-XvLY_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:06 INFO - Running setup.py (path:/tmp/pip-0lfgVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:06 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:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:06 INFO - Running setup.py (path:/tmp/pip-yZE_p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:07 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:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:07 INFO - Running setup.py (path:/tmp/pip-zGsBDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:07 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:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:07 INFO - Running setup.py (path:/tmp/pip-Sj5RKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:09 INFO - Downloading blessings-1.6.tar.gz 10:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:09 INFO - Installing collected packages: blessings 10:42:09 INFO - Running setup.py install for blessings 10:42:09 INFO - Successfully installed blessings 10:42:09 INFO - Cleaning up... 10:42:09 INFO - Return code: 0 10:42:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:09 INFO - Reading from file tmpfile_stdout 10:42:09 INFO - Current package versions: 10:42:09 INFO - argparse == 1.2.1 10:42:09 INFO - blessings == 1.6 10:42:09 INFO - blobuploader == 1.2.4 10:42:09 INFO - docopt == 0.6.1 10:42:09 INFO - functools32 == 3.2.3-2 10:42:09 INFO - jsonschema == 2.5.1 10:42:09 INFO - manifestparser == 1.1 10:42:09 INFO - mozInstall == 1.12 10:42:09 INFO - mozcrash == 0.17 10:42:09 INFO - mozdebug == 0.1 10:42:09 INFO - mozdevice == 0.48 10:42:09 INFO - mozfile == 1.2 10:42:09 INFO - mozhttpd == 0.7 10:42:09 INFO - mozinfo == 0.9 10:42:09 INFO - mozleak == 0.1 10:42:09 INFO - mozlog == 3.4 10:42:09 INFO - moznetwork == 0.27 10:42:09 INFO - mozprocess == 0.23 10:42:09 INFO - mozprofile == 0.28 10:42:09 INFO - mozrunner == 6.12 10:42:09 INFO - mozscreenshot == 0.1 10:42:09 INFO - mozsystemmonitor == 0.3 10:42:09 INFO - moztest == 0.7 10:42:09 INFO - mozversion == 1.4 10:42:09 INFO - psutil == 3.1.1 10:42:09 INFO - requests == 1.2.3 10:42:09 INFO - wsgiref == 0.1.2 10:42:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:09 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:42:09 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:42:09 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:42:09 INFO - Using env: {'DISPLAY': ':0', 10:42:09 INFO - 'HOME': '/home/cltbld', 10:42:09 INFO - 'LANG': 'en_US.UTF-8', 10:42:09 INFO - 'LANGUAGE': 'en_US:en', 10:42:09 INFO - 'LOGNAME': 'cltbld', 10:42:09 INFO - 'MAIL': '/var/mail/cltbld', 10:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:09 INFO - 'MOZ_NO_REMOTE': '1', 10:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:09 INFO - 'NO_EM_RESTART': '1', 10:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:09 INFO - 'PWD': '/builds/slave/test', 10:42:09 INFO - 'SHELL': '/bin/bash', 10:42:09 INFO - 'SHLVL': '1', 10:42:09 INFO - 'TERM': 'linux', 10:42:09 INFO - 'TMOUT': '86400', 10:42:09 INFO - 'USER': 'cltbld', 10:42:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:09 INFO - '_': '/tools/buildbot/bin/python'} 10:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 INFO - Cleaning up... 10:42:09 INFO - Return code: 0 10:42:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:09 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 0x7f4ee4881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, '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': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', '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:42:09 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:42:09 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:42:09 INFO - Using env: {'DISPLAY': ':0', 10:42:09 INFO - 'HOME': '/home/cltbld', 10:42:09 INFO - 'LANG': 'en_US.UTF-8', 10:42:09 INFO - 'LANGUAGE': 'en_US:en', 10:42:09 INFO - 'LOGNAME': 'cltbld', 10:42:09 INFO - 'MAIL': '/var/mail/cltbld', 10:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:09 INFO - 'MOZ_NO_REMOTE': '1', 10:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:09 INFO - 'NO_EM_RESTART': '1', 10:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:09 INFO - 'PWD': '/builds/slave/test', 10:42:09 INFO - 'SHELL': '/bin/bash', 10:42:09 INFO - 'SHLVL': '1', 10:42:09 INFO - 'TERM': 'linux', 10:42:09 INFO - 'TMOUT': '86400', 10:42:09 INFO - 'USER': 'cltbld', 10:42:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:09 INFO - '_': '/tools/buildbot/bin/python'} 10:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:42:09 INFO - Cleaning up... 10:42:09 INFO - Return code: 0 10:42:09 INFO - Running post-action listener: _resource_record_post_action 10:42:09 INFO - Running post-action listener: _start_resource_monitoring 10:42:10 INFO - Starting resource monitoring. 10:42:10 INFO - [mozharness: 2016-09-17 17:42:10.018308Z] Finished create-virtualenv step (success) 10:42:10 INFO - [mozharness: 2016-09-17 17:42:10.018771Z] Running install step. 10:42:10 INFO - Running pre-action listener: _resource_record_pre_action 10:42:10 INFO - Running main action method: install 10:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:10 INFO - Reading from file tmpfile_stdout 10:42:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:10 INFO - Reading from file tmpfile_stdout 10:42:10 INFO - Output received: 10:42:10 INFO - Usage: mozinstall [options] installer 10:42:10 INFO - Options: 10:42:10 INFO - -h, --help show this help message and exit 10:42:10 INFO - -d DEST, --destination=DEST 10:42:10 INFO - Directory to install application into. [default: 10:42:10 INFO - "/builds/slave/test"] 10:42:10 INFO - --app=APP Application being installed. [default: firefox] 10:42:10 INFO - mkdir: /builds/slave/test/build/application 10:42:10 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:42:10 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:42:26 INFO - Reading from file tmpfile_stdout 10:42:26 INFO - Output received: 10:42:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:42:26 INFO - Running post-action listener: _resource_record_post_action 10:42:26 INFO - [mozharness: 2016-09-17 17:42:26.353816Z] Finished install step (success) 10:42:26 INFO - [mozharness: 2016-09-17 17:42:26.354062Z] Running run-tests step. 10:42:26 INFO - Running pre-action listener: _resource_record_pre_action 10:42:26 INFO - Running main action method: run_tests 10:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:42:26 INFO - Python 2.7.3 10:42:26 INFO - Return code: 0 10:42:26 INFO - grabbing minidump binary from tooltool 10:42:26 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:42:26 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 0x276ef60>, '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 0x276fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27701d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:42:26 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:42:26 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:42:26 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:42:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:42:26 INFO - Return code: 0 10:42:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:42:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:42:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:42:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:42:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:42:26 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-007', '--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:42:26 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-007 --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:42:26 INFO - Using env: {'DISPLAY': ':0', 10:42:26 INFO - 'HOME': '/home/cltbld', 10:42:26 INFO - 'LANG': 'en_US.UTF-8', 10:42:26 INFO - 'LANGUAGE': 'en_US:en', 10:42:26 INFO - 'LOGNAME': 'cltbld', 10:42:26 INFO - 'MAIL': '/var/mail/cltbld', 10:42:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:42:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:26 INFO - 'MOZ_NO_REMOTE': '1', 10:42:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:26 INFO - 'NO_EM_RESTART': '1', 10:42:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:26 INFO - 'PWD': '/builds/slave/test', 10:42:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:42:26 INFO - 'SHELL': '/bin/bash', 10:42:26 INFO - 'SHLVL': '1', 10:42:26 INFO - 'TERM': 'linux', 10:42:26 INFO - 'TMOUT': '86400', 10:42:26 INFO - 'USER': 'cltbld', 10:42:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875', 10:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:26 INFO - '_': '/tools/buildbot/bin/python'} 10:42:26 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-007', '--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:42:26 INFO - mozversion application_buildid: 20160916143618 10:42:26 INFO - mozversion application_changeset: f2fe5345c13ff5ec70dc259d653298a7cac61423 10:42:26 INFO - mozversion application_display_name: Nightly 10:42:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:42:26 INFO - mozversion application_name: Firefox 10:42:26 INFO - mozversion application_remotingname: firefox 10:42:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:42:26 INFO - mozversion application_vendor: Mozilla 10:42:26 INFO - mozversion application_version: 51.0a1 10:42:26 INFO - mozversion platform_buildid: 20160916143618 10:42:26 INFO - mozversion platform_changeset: f2fe5345c13ff5ec70dc259d653298a7cac61423 10:42:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:42:26 INFO - mozversion platform_version: 51.0a1 10:42:26 INFO - using testdate: 1474134146 10:42:26 INFO - actual date: 1474134146 10:42:26 INFO - starting webserver on 'localhost:49063' 10:42:26 INFO - SUITE-START | Running 2 tests 10:42:26 INFO - TEST-START | dromaeo_css 10:42:26 INFO - operating with platform_type : linux_ 10:42:26 INFO - Initialising browser for dromaeo_css test... 10:42:26 INFO - TEST-INFO | started process 26122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2CaMwu/profile http://localhost:49063/getInfo.html) 10:42:30 INFO - PROCESS | 26122 | __metrics Screen width/height:1600/1200 10:42:30 INFO - PROCESS | 26122 | colorDepth:24 10:42:30 INFO - PROCESS | 26122 | Browser inner width/height: 1024/697 10:42:30 INFO - PROCESS | 26122 | __metrics 10:42:31 INFO - PROCESS | 26122 | 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:42:31 INFO - PROCESS | 26122 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:42:31 INFO - PROCESS | 26122 | console.error: PushService: 10:42:31 INFO - PROCESS | 26122 | stateChangeProcessEnqueue: Error transitioning state 10:42:31 INFO - PROCESS | 26122 | UnknownError 10:42:32 INFO - TEST-INFO | 26122: exit 0 10:42:32 INFO - Browser initialized. 10:42:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:42:32 INFO - TEST-INFO | started process 26203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2CaMwu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:42:44 INFO - PROCESS | 26203 | RSS: Main: 174120960 10:42:44 INFO - PROCESS | 26203 | 10:43:06 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:43:36 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:43:36 INFO - PROCESS | 26203 | 1474134216340 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:43:39 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.28339 seconds. 10:43:40 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.16669 seconds. 10:43:45 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:43:50 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:43:54 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:43:59 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.23338 seconds. 10:44:00 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:44:02 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.06672 seconds. 10:44:08 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:44:11 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:44:13 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:44:15 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.18343 seconds. 10:44:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:44:29 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 10:44:50 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.18339 seconds. 10:44:56 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:45:03 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:45:05 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:45:07 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:45:11 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:45:13 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:45:17 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:45:30 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:45:35 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.70012 seconds. 10:45:37 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:45:42 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.06671 seconds. 10:45:48 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49063/tests/dromaeo/cssquery-ext.html) 10:45:50 INFO - PROCESS | 26203 | RSS: Main: 293834752 10:45:50 INFO - PROCESS | 26203 | 10:45:58 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 10:46:03 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:46:16 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:46:25 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:46:44 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:47:00 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:47:11 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:47:13 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:47:21 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:47:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:47:27 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:47:29 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:47:34 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:47:39 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:47:45 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:47:47 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:47:52 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:47:53 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 2.00008 seconds. 10:47:54 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:48:10 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:48:14 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 10:48:18 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:48:29 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:48:30 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:48:40 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:48:44 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:48:52 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-ext.html (next: http://localhost:49063/tests/dromaeo/cssquery-jquery.html) 10:48:53 INFO - PROCESS | 26203 | RSS: Main: 282308608 10:48:53 INFO - PROCESS | 26203 | 10:48:57 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:48:59 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 2.05009 seconds. 10:49:10 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:49:15 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:49:18 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:49:32 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:49:40 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:49:56 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:50:00 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:50:02 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:50:08 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 10:50:10 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:50:28 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 10:50:33 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:50:39 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:50:49 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:50:54 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:15 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:21 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:51:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 10:51:53 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:51:55 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49063/tests/dromaeo/cssquery-mootools.html) 10:51:56 INFO - PROCESS | 26203 | RSS: Main: 219938816 10:51:56 INFO - PROCESS | 26203 | 10:52:01 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 10:52:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:52:25 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 10:52:46 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 10:53:05 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:53:17 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:53:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:53:20 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 2.01676 seconds. 10:53:31 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:53:54 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:53:56 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:10 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 10:54:12 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:16 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:36 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 10:54:40 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:54:46 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:54:58 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49063/tests/dromaeo/cssquery-prototype.html) 10:54:59 INFO - PROCESS | 26203 | RSS: Main: 217751552 10:54:59 INFO - PROCESS | 26203 | 10:55:02 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 10:55:05 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 10:55:13 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 10:55:16 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 10:55:24 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 10:55:33 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 10:55:50 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:55:53 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:55:56 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:56:04 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:56:10 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:56:12 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:56:20 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:26 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:29 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:44 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:56:49 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:56:57 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 10:57:00 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:57:03 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:57:07 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:57:09 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:57:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:57:21 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:57:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:27 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:57:32 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:43 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 10:57:50 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 10:57:52 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:57:58 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:58:02 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49063/tests/dromaeo/cssquery-yui.html) 10:58:03 INFO - PROCESS | 26203 | RSS: Main: 218390528 10:58:03 INFO - PROCESS | 26203 | 10:58:06 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 10:58:13 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 10:58:17 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:58:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:58:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 10:58:45 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 10:58:58 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 10:59:08 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 10:59:18 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 10:59:20 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 11:00:04 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 11:00:06 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 11:00:12 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 11:00:15 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 11:00:19 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 11:00:23 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 11:00:26 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 11:00:43 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01658 seconds. 11:00:55 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 11:00:57 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 11:00:59 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 11:01:05 INFO - PROCESS | 26203 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 11:01:05 INFO - PROCESS | 26203 | Cycle 1(1): loaded http://localhost:49063/tests/dromaeo/cssquery-yui.html (next: http://localhost:49063/tests/dromaeo/cssquery-dojo.html) 11:01:06 INFO - PROCESS | 26203 | RSS: Main: 309882880 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | __start_tp_report 11:01:06 INFO - PROCESS | 26203 | _x_x_mozilla_page_load 11:01:06 INFO - PROCESS | 26203 | _x_x_mozilla_page_load_details 11:01:06 INFO - PROCESS | 26203 | |i|pagename|runs| 11:01:06 INFO - PROCESS | 26203 | |0;dojo.html;2588.857612831295;2616.136674897284;2640.432307053983;2658.2424009157394;2670.1055146525914;4601.079784043188;4664.230401983677;4731.90536189276;4751.192297309457;4819.397575303087;4683.555062269087;4705.200115980283;4721.976390118053;4740.857774266778;4803.303520989463;4245.596668316505;4281.05816720321;4320.654347652196;4326.048269380732;4377.912441751163;4321.438213032301;4349.195398851222;4377.168338015783;4400.207962566737;4425.336199570074;4356.477222733292;4383.298672212447;4397.12057588482;4407.405000324947;4439.667024973124;4293.742375457483;4345.044090300129;4353.73877567347;4391.143726973241;4403.581659742319;4273.166732487166;4274.444322238121;4312.719673221262;4328.11273688893;4361.6074553290355;4625.907481850378;4708.552687494716;4730;4740.739259340735;4782.210935195689;5040.647154699136;5051.267566202917;5056.696598204083;5057.342545469102;5122.282880396748;4910.337104490919;4958;5027.723475208862;5072.036313100499;5092.719900405476;4746.857594272108;4753.405824271931;4758.524147585283;4766.833160839354;4807.735574543363;5194.506521880416;5228.764705588258;5232.738363081907;5234.293370395024;5285.709285989307;4830.686005409637;4839.661223714376;4868.732219727949;4868.8782780430065;4883.02339532095;4984.925226121611;4989.451160372356;4989.925151122736;4990.326305948723;5029.321041659329;4929.876753081202;4936.284238785356;4940.357753492095;4985.90028199434;4998.90002199954;4851.733154676526;4901.58336541398;4907.1167189905445;4943.826966056243;4958.429780575208;4207.242696314632;4217.304144816071;4218.388333691598;4266.189424009428;4272.829086836554;3701.981490092532;3706.258748250361;3708.8873337998493;3743.681787048077;3751.493548370935;4237.8304867805555;4280.101178752497;4402.933955990663;4409.735415875058;4445.488768791565;4962.106820772296;4999.800007999712;5000.199968005102;5026.120428924996;5064.139096353555;4333.414988976511;4334.566543345703;4338.045629961403;4348.7390756554705;4395.780210989437;4303.33298338758;4448.866534003985;4454.10917816438;4454.643628509712;4504.752238626907;4648.744319062416;4684.578387945101;4720.291956206596;4727.550882666142;4766.45185803637;4983.925241121314;4990.4011518618;4995.575376093073;5005.849824505271;5043.420006699276;4717.056588682346;4721.409823772028;4722.622190224843;4725.952740472551;4786.569208771228;4813.590844778233;4848.660593758545;4945.925811112908;4973.900521989468;4997.525235102659;5065.164247899203;5076.670016448919;5085.7457127144235;5091.261767043832;5135.409427915837;4928.630352723489;4929.802807887788;4935.950640493549;4938.358013458227;4969.055879382906;4778.641601879943;4808.0383923214795;4860.684055536379;4896.92654610174;4975.477574854733;4855.028994201103;4862;4863.2461968394955;4898.975505122452;4924.581410579997;4883.413990321184;4919.926201107058;4959.9008019838675;4963.106640804545;4963.875903102451;4796.472388037383;4833.05755377712;4833.903321933612;4839.975800120977;4846.151923413318 11:01:06 INFO - PROCESS | 26203 | |1;ext.html;557.6263903184865;560.5767645427702;562.8283373571064;569.427725136238;571.9190729521205;27401.862990685044;29845.403091938177;29853.253668658293;38217.42673859887;39538;40800.59199408005;40870;40940.18119637613;41184.58815411852;41266;7511.286427789365;7658.65536050879;7660.463767536275;7663.923360766376;7668.501547399429;7414.59219742914;7491.475596708233;7492.812679683025;7493.73771917983;7495.063117110361;7511.661975211101;7551.433642476809;7554.69781208751;7557.47097703161;7566.20554841742;7467.962660186691;7502.887456688154;7509.436792240604;7516.947627332123;7520;7565.13001004886;7633.0458692663415;7633.274838890296;7641.541507509512;7642.082950045974;37163;37556.81221593902;37574;37586.81206593977;37612.811935940146;2681.6781986161786;2704.1752265559;2851.201663534214;3113.719765221141;3334.3498017886523;25079.49841003188;29408.264793380124;30163.698363016527;30286.69713302883;30323.848380758176;3064.8620812063286;3152.5271209318557;3258.560094387251;3315.552400425936;3337.9666203337897;255123;257670;257731;258567;258570;30878.22804429907;31704;52926;53516.197257041174;53591.73204133954;32300.515492267634;32665.18337041593;32879.34241315208;32901.50647740286;32918;11647.76704465906;11832.940835295769;11852.644420667393;11875;11916.16586838913;9507.096825801538;9570.712878613653;9586.28102892272;9591.232701383873;9601.759956001157;7711.652975616111;7789.532628042222;7839.490433121829;7841.960790196013;7845.254700803414;2977.687342828972;2987.985060074686;3028.212664707192;3042.6196725409322;3069.4014667139695;832.3299743706253;851.29342645604;879;885.2961895293257;919.1865199298535;27209.183724488295;27795.722042779315;28251;28412.857935710188;28457.715422845507;854.9145085491401;892.7678803511134;940.8682784410188;941.2799208605422;947.3463310315998;13750.587482375544;14760.619690154923;14775.778363324558;14940.477083302032;15177.24113794306;382615;386829;387434;387742;388073;47331.526684732715;47664.28503572449;47743.522564773906;47766.761166193945;47844.76077619589;1019.2152042926905;1058.5130839813771;1112.4437781109445;1130.1580322659672;1147.8106112491512;27275.454490910466;28382;29284.853575731984;29530.114096577137;29739.702602974558;40344.798276009606;40747.18505629811;40747.59252407438;40851.591484084776;40945.38581921214;274350;275701;275913;276293;276665;22089.66865497051;22814.42963925915;38715.612843872324;39209.215815684096;39653.80173099116;39067.41398878962;42451.3632295522;42554.36168457538;43651.781741091094;44273.77863110664;36461.45307820332;36484.60188846272;37281.44077838889;37608.811955940044;38244.80877595594;36527.817360913024;36699.63300366962;36862.078448039014;37281.44077838889;37489.250214995;35364;35728.10679733028;35787;35996.64003360038;35999;31164;33503.66496335006;33720;33854.322913542084;33859.661403386635;25021.12426065079;25230.74769252284;25305;26055;26263 11:01:06 INFO - PROCESS | 26203 | |2;jquery.html;325.91526203187163;329.78234365318895;350.18057744876984;350.61957775813244;358.1869157013579;10848;11952.282863028224;15174.089554626717;15642.84357156428;16647.084410357427;16312;16413.261403236855;16441.753373699405;16606.335746570123;16676.249568769403;4472.41858558387;4912.238603016538;5107.978404319132;5108.693478391308;5110.974445127769;5933.821985340447;6037.124616930542;6038.124471951564;6050.122732203828;6094.268687757475;5878.177055212273;5892.116182572606;6006.699665016754;6048.516118710492;6050.03199488082;5925.170476133323;5936.28764548257;5955.940440595582;5958.940410595882;5983.461488466037;4557.886052848672;4799.424069111729;4838.637102217348;4911.312416261726;5184.481551844823;11286.492107855167;11499.942500287445;11515.827262591069;11524.711882202928;17871.642567148585;1745.8166892476233;1763.8765286429955;1794.9675203464521;2011;2231.475603233239;9054.637814487412;9287.860682089775;10198.541065652063;11753;13501.2574308413;1718.5274049636325;1721.535185499908;1753.8070812210647;1756.8331008554294;1775.6271183051574;55369.72315138399;59924;68097.65951170262;69858.65070674664;72365.27634723637;9642;9808.831246720116;9862.901370986341;10058.849117263248;10060.647877324405;13529.59411217665;13538;13543.59369218925;13567.118137321042;13576.253306068063;6574.80275591733;6848.589084654936;6891.173059232924;6897.7240910363025;6981.825454363681;6505.316941721051;6514.250861150934;6635.8009259722285;6675.566088204251;6722.731090756315;4031.879043628696;4116.485439320085;4131.5248746394545;4175.728577642504;4299.505556861001;1785.9107044647715;1786.490850107713;1795.5062357851434;1831.1851226204212;1859.2284202056267;796.8246985663145;797.2824457987741;821.4332110843499;833.5415521463171;851.4720873058743;15431.074135551678;16253.512394627944;16411.753823692656;16654.16729163537;17331.133443327784;803.6303300481727;816.7835523586255;833.7707130539151;834.5785378383878;892.4199270474244;8666.306695464347;9138.68014619485;9545.52272386378;9637.976743837698;9703.66037188695;374637;382773;388125;393898;398345;77258.22741772623;77587.61206193933;82173.58913205516;82695.17304826995;82699;867.509856930832;883.7702197428587;924.5515924776478;928.1692884868005;936.9344145909721;14301.642458938193;15160.620984475476;15781.132037738034;15925.840741592436;16146.838531615003;35080.47379289364;36783.63216367909;39034.80482597569;41027;41762.37356439717;50619;53148.46851531435;53846.730766345914;54515.72742136264;54877;6961.825954351182;7213.963930180315;7334.156571994289;7579.393648507996;7617.581033043236;10892.405506182782;11063.668089957315;11114.722131946766;11316;11655.53377864876;9944.254180936314;9953.651622193189;10247.128994035591;10411.21915856329;10737.570497180337;9911.950440248042;9987.700368988943;10187.592496300362;10486.161107111566;10595.841062383915;9798.265130115413;10173.186145108522;10281.074703276741;10424.791504170025;10644.361338319726;7091.822704432224;7118.074650295428;7297.160826504807;7534.623268836646;8046.074701409413;9301.395409298373;9621.807563848824;9769.609215631295;9787.33135147488;9900.158486528726 11:01:06 INFO - PROCESS | 26203 | |3;mootools.html;1187.4775098956452;1274.9490020399185;1329.65428988463;1353.3503918119302;1607.3731244814524;6501.642409667466;7240.094988126484;7522.247775222475;7543.245675432454;7758.49569777964;7627.199144089874;7695.5382677039415;7699.230076992298;7702.730404435846;7704.53772773634;2085.8644188127723;2112.1868080788854;2113.2709215320688;2113.471632091977;2114.7990940860595;2061.5773766377856;2095.235239137719;2114.164904862578;2115.3971118231307;2123.4266747978036;2070.6272870883236;2073.3365323096614;2083.1771450277133;2084.7289852319177;2087.2485905074236;2085.8748475091465;2089.5716378142442;2091.98954005229;2092.455961450034;2093.5708179823177;2055.8869262190574;2062.7730949595534;2095.916163353464;2096.2767845093417;2102.7897210278848;7435.814104647373;7595.088589369311;7633.580153091578;7714.267144621252;7716.922830771677;4209.200251952119;4326.935095973563;4347.760873151976;4349.151915376503;4352.325389564622;2719;2804.845733484678;2849.529827578447;2850.2446851584345;2856.48583255014;910.8588168833842;916.5829547555846;932.4265576670299;936.7330310861372;938.7183844846587;10096.242781791321;10187.235957303232;10230.181585473145;10241.539130739135;10245.129164021067;3613.855445782192;3758.680512156497;3859.0931131184147;3888.9611103889165;3916.784576848244;8067.0722866871065;8088.595570221465;8097.190280971856;8101.594920254081;8103.797405064803;4170.124273902454;4198.454200953856;4201.810918508674;4214.072903961123;4216.852410165629;3358.328334333143;3478.4260597001717;3857.517810273716;3922.627350401707;3943.901402464904;3302.7192688621735;3359.3617212729505;3454.7581669283413;3459.7232221422228;3460.602030766444;1013.6654903881702;1018.6332920148741;1033.2302434686208;1038.657243109772;1039.7211429941215;721.8844984802406;723.7322190789337;743.2344684974485;752.3116348541133;767.244264399566;5017.046761115376;5035.546800787946;5100.081985242692;5194.714290713971;5291.788328466895;761.1209053543166;831.0193971114022;840.684743221292;846.6232526525637;851.3189448441223;3170.793898396597;3291.391092647868;3390.711789497871;3448.9827550862087;3553.022918697327;9091.727248182566;9538.761530961643;9553.04469553039;9560;9568.234541236685;8830.293576513863;9346.626134954662;9475.90524094764;9514.28642851789;9516.429014259167;7118.28817118284;7291.08861392326;7323.523970941872;7328.67020984057;7331.633418329169;5272.499112584298;5454.072807622634;5499.450054994629;5507.807226747044;5610.943890561042;8432.83134337322;8668.263197628272;8820.64717411322;8830.249428798625;8874;8784.979454725577;8985.415947963362;9040.547972601213;9053.818923621622;9112.544372781467;5804.912926306193;6020;6715.563488373436;6840.657967101525;6856.417204537471;6774.254831968381;7069.257727938492;7083.610401427971;7307.561546307238;7310;6418.582792118497;6491.578047426902;6580.374864387875;6628.105205797156;6839.974003899455;6701.497387696039;6709.4632429404555;6758.7296508139125;6767.593944363354;6805.523613347018;5980.401959803985;6068.51451883857;6075.362086980804;6077.301110372364;6080.148779170831;4390.934135987899;4400.229959757094;4477.910441791211;4524.660650451295;4528.592426681615;4413.691041627184;4451.5771001756075;4455.7994890229365;4462.107578484381;4539.477960034506 11:01:06 INFO - PROCESS | 26203 | |4;prototype.html;278.8940202722965;285.64865215784596;286.24431500837807;286.30999291706985;295.94672958867403;4752.881177970552;4786.56920877121;4789.233722604384;4793.400824896888;4813.157697402949;4712.85861424157;4718.764061796905;4724.102420540095;4730.526947305268;4743.928841067387;3551.307495038462;3578.982105089484;3642.380795264798;3682.263547290539;3731.104534911629;3709.5548534175937;3722.4230244312175;3723.664870161685;3733;3733.757305775116;3675.117971686803;3675.9448608270895;3682.6501482359267;3699.260147970403;3699.519062521882;3483.303339332131;3557.1107223194203;3607.24247907941;3704.184949374814;3715.256948610289;3277.524758909945;3279.884839154699;3290;3291.3417316536547;3294.357600267949;4616.907661846744;4619.637207023936;4622.884427889296;4629.629629629621;4631.675782695213;3898.571157172709;4146.979265103685;4240.257954857888;4247.129338485603;4247.745135291892;4909.410870695504;4909.509049095098;4913.852584422473;4930.630202734809;4944.258361245806;3475.669811367916;3481.56480439945;3493.2489514754448;3494.318607871466;3500.1074725944977;5059.16523773577;5177.301064356301;5202.739863006835;5214.608904332153;5214.869628259324;3533.9293214135573;3552.5736911570775;3555.6977656898935;3566.3937130687846;3569.6787289144104;3621.8229075550553;3625.22364041623;3631.3100510902846;3636;3656.689181419556;4117.97941010293;4130.339145736668;4143.7928103594695;4144.7513149211145;4145.440365550612;4666.883327916829;4859.416869975626;4937.5556199942175;4938.407391113089;4947.975260123676;1211.1824518450012;1230.6185082624236;1232.4269214815154;1233.1183204009176;1239.1573729863778;766.9731559395506;790.6481615681082;797.1351084073845;804.5253300552702;808.6563210635574;3982.2234664240773;4221.894452638709;4319.719218250803;4329.696921215547;4431.135928493977;5085.160948443539;5100.770465329069;5109.675097830478;5113.258577506241;5143.177091665316;4425.712328698624;4440.444944381952;4453.376527286183;4459.5986361227;4467.776611169428;2613.882375293116;2651.840889546633;2664.720204378551;2670.1588999465107;2670.692870319899;4787.808487660524;4807.735574543433;4824.0834241494;4828.589569886599;4833.806647734122;5188.870278242998;5203.115470370046;5206.245094461282;5214.843554693365;5217;4673.205555055649;4790.473047964721;4816.349792778;4825.95174048255;4827.758612069452;5077.441481437113;5088.160453525127;5095.363079615048;5101.92347114801;5104.744762761921;4962.057209130254;4969.751512424436;5003.799848006039;5004.974975125101;5015.498450154955;4568.314752787109;4745.501722319244;4769.546893045155;4774.3315935769715;4813.422389313305;3590.7666001709804;3593.155608431964;3594.8562057517406;3595.06528302638;3604.13500759821;5070.721110338966;5135.563477104339;5137.255098010843;5148.279240906201;5158.406783219978;4719.961608446137;4944.604431645532;4960.627952903475;4973.229149481836;5001.624878134082;4945.109880221451;4956.553910148104;4961.627877909099;4964.560277519479;4974.328465657235;4887.877803054952;4897.946941407615;4903.583195428429;4904.852854414374;4907.656464047483;4697.976510117564;4726.409198850144;4921.769557610597;4965.106280869478;4981.825636102719;4667.906641867075;4773.689710168828;4811.302361157683;4852.19938710123;4852.344933433941 11:01:06 INFO - PROCESS | 26203 | |5;yui.html;559.8012705489551;585.5491271720775;626.1046703214402;642.4282388674079;660.3990368764426;10765.892341076596;11252.718682032953;11325.943370283147;11330.150238732098;12167.330796806173;12459.937700311508;12468.438920248587;12548.309842958633;12550.184238024545;12561.434735436904;729.2343039808194;746.0599644448007;746.6640011994597;746.7796999885047;747.495440577608;587.3451102021259;602.9276486821587;726.0670038999887;746.3320328306163;753.3897542990168;774.1484367196067;782.8708263136575;782.8708263136575;783.0837919634014;783.1776634533745;772.169917338863;774.175503089211;774.9925097373421;775.7207405334075;775.8836174573803;450.1357393803904;457.569884308752;552.6048875054315;565.197419664078;571.0663065887263;11889.405529723479;11958.701032474171;11996.460159292852;12013.459394327276;12031.037516998707;11556.653300401002;11774.411279435993;12052.819207711891;12191.146619736623;12309.56916507918;9680.128788409076;9818.45998470084;10033.297669163161;11386.259893106922;11523.827142592867;4061.939070913939;4103.158852435274;4106.2198182345255;4156.521999970012;4172.08214192877;60252;60384.698076509776;61322;61679;62333;10143.949280253551;10254.48727563619;10420.635277765241;10547.789044219073;10725.731856703489;17669.469915902544;17683.911580442014;17687;17779.73330400019;17781.822181778018;6275.529335299871;6326.2724786649205;6456.677166141768;6515.446187074152;6537.673116344259;3484.790912545255;3496.7727097738566;3513.894583162509;3516.9120771980906;3561.0385195996937;2505.6241563765216;2624.6719160104985;2626.448445826398;2628.6976997645133;2629.618705287761;470.7787339950218;507.58124547248667;513.4942082049179;513.599392473871;538.6364204162174;484.2228223700909;533.7918211897363;551.2585572405109;551.5119119579201;553.5303768494654;7964.646010178283;8092.473989190684;8103;8315.667373305;8478.74563763088;487.1961263914569;505.96205284603803;509.80882169186555;511.29186077282486;519.1460048220731;3680.871169509054;3842.423636454554;3854.6530812227033;3953.5651078381356;3965.524137103566;103039.484802577;103920;104973;105132.47433762782;107481.46259268654;86899;88534.55732721424;89811.55094224487;90410.54794725984;91823.5408822965;78503;78508.6074569635;78653.60673196711;78940.1059894006;80036.59981700055;7593.848123037398;7812.92187078122;7821.335186508983;7879.369650427838;7939.523628582304;45031.54968450274;45503;45882.311765324215;46660.766696166305;48357;64397;66194.38764542139;66376.6681166591;66588.33411665821;70392.64803675949;9218.953905230432;9256.722298330791;9391.765205869908;9553.61785528571;9611.903880961381;10200.38797672142;10223.386596804216;10287.331323463952;10346.482675866328;10479.214058945458;9611.69275832743;9867.457289849128;9974.451405172495;10024.699259022242;10096.141827944413;11299.548018079513;11391.829122563002;11480.712982175512;11498.655040348804;11509.251898626562;10711.357318560911;10820.729481763019;10836.891631083588;11686.532538698697;11963.102767292314;9175.954120229357;9274.165325120503;9485.715428537154;9673.903260967581;10308.639197628347;9525.333226674065;9903.702888913343;9951.651692190739;10055.49722513886;10068.798624027624 11:01:06 INFO - PROCESS | 26203 | __end_tp_report 11:01:06 INFO - PROCESS | 26203 | __start_cc_report 11:01:06 INFO - PROCESS | 26203 | _x_x_mozilla_cycle_collect,1011 11:01:06 INFO - PROCESS | 26203 | __end_cc_report 11:01:06 INFO - PROCESS | 26203 | __startTimestamp1474135266127__endTimestamp 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | ------- Summary: start ------- 11:01:06 INFO - PROCESS | 26203 | Number of tests: 6 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#0] dojo.html Cycles:165 Average:4647.49 Median:4786.57 stddev:483.32 (10.1%) stddev-sans-first:457.02 11:01:06 INFO - PROCESS | 26203 | Values: 2588.9 2616.1 2640.4 2658.2 2670.1 4601.1 4664.2 4731.9 4751.2 4819.4 4683.6 4705.2 4722.0 4740.9 4803.3 4245.6 4281.1 4320.7 4326.0 4377.9 4321.4 4349.2 4377.2 4400.2 4425.3 4356.5 4383.3 4397.1 4407.4 4439.7 4293.7 4345.0 4353.7 4391.1 4403.6 4273.2 4274.4 4312.7 4328.1 4361.6 4625.9 4708.6 4730.0 4740.7 4782.2 5040.6 5051.3 5056.7 5057.3 5122.3 4910.3 4958.0 5027.7 5072.0 5092.7 4746.9 4753.4 4758.5 4766.8 4807.7 5194.5 5228.8 5232.7 5234.3 5285.7 4830.7 4839.7 4868.7 4868.9 4883.0 4984.9 4989.5 4989.9 4990.3 5029.3 4929.9 4936.3 4940.4 4985.9 4998.9 4851.7 4901.6 4907.1 4943.8 4958.4 4207.2 4217.3 4218.4 4266.2 4272.8 3702.0 3706.3 3708.9 3743.7 3751.5 4237.8 4280.1 4402.9 4409.7 4445.5 4962.1 4999.8 5000.2 5026.1 5064.1 4333.4 4334.6 4338.0 4348.7 4395.8 4303.3 4448.9 4454.1 4454.6 4504.8 4648.7 4684.6 4720.3 4727.6 4766.5 4983.9 4990.4 4995.6 5005.8 5043.4 4717.1 4721.4 4722.6 4726.0 4786.6 4813.6 4848.7 4945.9 4973.9 4997.5 5065.2 5076.7 5085.7 5091.3 5135.4 4928.6 4929.8 4936.0 4938.4 4969.1 4778.6 4808.0 4860.7 4896.9 4975.5 4855.0 4862.0 4863.2 4899.0 4924.6 4883.4 4919.9 4959.9 4963.1 4963.9 4796.5 4833.1 4833.9 4840.0 4846.2 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#1] ext.html Cycles:180 Average:45024.02 Median:37523.03 stddev:82239.80 (219.2%) stddev-sans-first:82402.74 11:01:06 INFO - PROCESS | 26203 | Values: 557.6 560.6 562.8 569.4 571.9 27401.9 29845.4 29853.3 38217.4 39538.0 40800.6 40870.0 40940.2 41184.6 41266.0 7511.3 7658.7 7660.5 7663.9 7668.5 7414.6 7491.5 7492.8 7493.7 7495.1 7511.7 7551.4 7554.7 7557.5 7566.2 7468.0 7502.9 7509.4 7516.9 7520.0 7565.1 7633.0 7633.3 7641.5 7642.1 37163.0 37556.8 37574.0 37586.8 37612.8 2681.7 2704.2 2851.2 3113.7 3334.3 25079.5 29408.3 30163.7 30286.7 30323.8 3064.9 3152.5 3258.6 3315.6 3338.0 255123.0 257670.0 257731.0 258567.0 258570.0 30878.2 31704.0 52926.0 53516.2 53591.7 32300.5 32665.2 32879.3 32901.5 32918.0 11647.8 11832.9 11852.6 11875.0 11916.2 9507.1 9570.7 9586.3 9591.2 9601.8 7711.7 7789.5 7839.5 7842.0 7845.3 2977.7 2988.0 3028.2 3042.6 3069.4 832.3 851.3 879.0 885.3 919.2 27209.2 27795.7 28251.0 28412.9 28457.7 854.9 892.8 940.9 941.3 947.3 13750.6 14760.6 14775.8 14940.5 15177.2 382615.0 386829.0 387434.0 387742.0 388073.0 47331.5 47664.3 47743.5 47766.8 47844.8 1019.2 1058.5 1112.4 1130.2 1147.8 27275.5 28382.0 29284.9 29530.1 29739.7 40344.8 40747.2 40747.6 40851.6 40945.4 274350.0 275701.0 275913.0 276293.0 276665.0 22089.7 22814.4 38715.6 39209.2 39653.8 39067.4 42451.4 42554.4 43651.8 44273.8 36461.5 36484.6 37281.4 37608.8 38244.8 36527.8 36699.6 36862.1 37281.4 37489.3 35364.0 35728.1 35787.0 35996.6 35999.0 31164.0 33503.7 33720.0 33854.3 33859.7 25021.1 25230.7 25305.0 26055.0 26263.0 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#2] jquery.html Cycles:180 Average:24003.64 Median:27765.62 stddev:64125.64 (231.0%) stddev-sans-first:64280.88 11:01:06 INFO - PROCESS | 26203 | Values: 325.9 329.8 350.2 350.6 358.2 10848.0 11952.3 15174.1 15642.8 16647.1 16312.0 16413.3 16441.8 16606.3 16676.2 4472.4 4912.2 5108.0 5108.7 5111.0 5933.8 6037.1 6038.1 6050.1 6094.3 5878.2 5892.1 6006.7 6048.5 6050.0 5925.2 5936.3 5955.9 5958.9 5983.5 4557.9 4799.4 4838.6 4911.3 5184.5 11286.5 11499.9 11515.8 11524.7 17871.6 1745.8 1763.9 1795.0 2011.0 2231.5 9054.6 9287.9 10198.5 11753.0 13501.3 1718.5 1721.5 1753.8 1756.8 1775.6 55369.7 59924.0 68097.7 69858.7 72365.3 9642.0 9808.8 9862.9 10058.8 10060.6 13529.6 13538.0 13543.6 13567.1 13576.3 6574.8 6848.6 6891.2 6897.7 6981.8 6505.3 6514.3 6635.8 6675.6 6722.7 4031.9 4116.5 4131.5 4175.7 4299.5 1785.9 1786.5 1795.5 1831.2 1859.2 796.8 797.3 821.4 833.5 851.5 15431.1 16253.5 16411.8 16654.2 17331.1 803.6 816.8 833.8 834.6 892.4 8666.3 9138.7 9545.5 9638.0 9703.7 374637.0 382773.0 388125.0 393898.0 398345.0 77258.2 77587.6 82173.6 82695.2 82699.0 867.5 883.8 924.6 928.2 936.9 14301.6 15160.6 15781.1 15925.8 16146.8 35080.5 36783.6 39034.8 41027.0 41762.4 50619.0 53148.5 53846.7 54515.7 54877.0 6961.8 7214.0 7334.2 7579.4 7617.6 10892.4 11063.7 11114.7 11316.0 11655.5 9944.3 9953.7 10247.1 10411.2 10737.6 9912.0 9987.7 10187.6 10486.2 10595.8 9798.3 10173.2 10281.1 10424.8 10644.4 7091.8 7118.1 7297.2 7534.6 8046.1 9301.4 9621.8 9769.6 9787.3 9900.2 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#3] mootools.html Cycles:180 Average:4948.77 Median:5372.93 stddev:2807.36 (52.3%) stddev-sans-first:2801.00 11:01:06 INFO - PROCESS | 26203 | Values: 1187.5 1274.9 1329.7 1353.4 1607.4 6501.6 7240.1 7522.2 7543.2 7758.5 7627.2 7695.5 7699.2 7702.7 7704.5 2085.9 2112.2 2113.3 2113.5 2114.8 2061.6 2095.2 2114.2 2115.4 2123.4 2070.6 2073.3 2083.2 2084.7 2087.2 2085.9 2089.6 2092.0 2092.5 2093.6 2055.9 2062.8 2095.9 2096.3 2102.8 7435.8 7595.1 7633.6 7714.3 7716.9 4209.2 4326.9 4347.8 4349.2 4352.3 2719.0 2804.8 2849.5 2850.2 2856.5 910.9 916.6 932.4 936.7 938.7 10096.2 10187.2 10230.2 10241.5 10245.1 3613.9 3758.7 3859.1 3889.0 3916.8 8067.1 8088.6 8097.2 8101.6 8103.8 4170.1 4198.5 4201.8 4214.1 4216.9 3358.3 3478.4 3857.5 3922.6 3943.9 3302.7 3359.4 3454.8 3459.7 3460.6 1013.7 1018.6 1033.2 1038.7 1039.7 721.9 723.7 743.2 752.3 767.2 5017.0 5035.5 5100.1 5194.7 5291.8 761.1 831.0 840.7 846.6 851.3 3170.8 3291.4 3390.7 3449.0 3553.0 9091.7 9538.8 9553.0 9560.0 9568.2 8830.3 9346.6 9475.9 9514.3 9516.4 7118.3 7291.1 7323.5 7328.7 7331.6 5272.5 5454.1 5499.5 5507.8 5610.9 8432.8 8668.3 8820.6 8830.2 8874.0 8785.0 8985.4 9040.5 9053.8 9112.5 5804.9 6020.0 6715.6 6840.7 6856.4 6774.3 7069.3 7083.6 7307.6 7310.0 6418.6 6491.6 6580.4 6628.1 6840.0 6701.5 6709.5 6758.7 6767.6 6805.5 5980.4 6068.5 6075.4 6077.3 6080.1 4390.9 4400.2 4477.9 4524.7 4528.6 4413.7 4451.6 4455.8 4462.1 4539.5 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#4] prototype.html Cycles:180 Average:4099.65 Median:4715.81 stddev:1202.60 (25.5%) stddev-sans-first:1171.28 11:01:06 INFO - PROCESS | 26203 | Values: 278.9 285.6 286.2 286.3 295.9 4752.9 4786.6 4789.2 4793.4 4813.2 4712.9 4718.8 4724.1 4730.5 4743.9 3551.3 3579.0 3642.4 3682.3 3731.1 3709.6 3722.4 3723.7 3733.0 3733.8 3675.1 3675.9 3682.7 3699.3 3699.5 3483.3 3557.1 3607.2 3704.2 3715.3 3277.5 3279.9 3290.0 3291.3 3294.4 4616.9 4619.6 4622.9 4629.6 4631.7 3898.6 4147.0 4240.3 4247.1 4247.7 4909.4 4909.5 4913.9 4930.6 4944.3 3475.7 3481.6 3493.2 3494.3 3500.1 5059.2 5177.3 5202.7 5214.6 5214.9 3533.9 3552.6 3555.7 3566.4 3569.7 3621.8 3625.2 3631.3 3636.0 3656.7 4118.0 4130.3 4143.8 4144.8 4145.4 4666.9 4859.4 4937.6 4938.4 4948.0 1211.2 1230.6 1232.4 1233.1 1239.2 767.0 790.6 797.1 804.5 808.7 3982.2 4221.9 4319.7 4329.7 4431.1 5085.2 5100.8 5109.7 5113.3 5143.2 4425.7 4440.4 4453.4 4459.6 4467.8 2613.9 2651.8 2664.7 2670.2 2670.7 4787.8 4807.7 4824.1 4828.6 4833.8 5188.9 5203.1 5206.2 5214.8 5217.0 4673.2 4790.5 4816.3 4826.0 4827.8 5077.4 5088.2 5095.4 5101.9 5104.7 4962.1 4969.8 5003.8 5005.0 5015.5 4568.3 4745.5 4769.5 4774.3 4813.4 3590.8 3593.2 3594.9 3595.1 3604.1 5070.7 5135.6 5137.3 5148.3 5158.4 4720.0 4944.6 4960.6 4973.2 5001.6 4945.1 4956.6 4961.6 4964.6 4974.3 4887.9 4897.9 4903.6 4904.9 4907.7 4698.0 4726.4 4921.8 4965.1 4981.8 4667.9 4773.7 4811.3 4852.2 4852.3 11:01:06 INFO - PROCESS | 26203 | 11:01:06 INFO - PROCESS | 26203 | [#5] yui.html Cycles:180 Average:18000.34 Median:510.55 stddev:26954.44 (5279.5%) stddev-sans-first:26998.24 11:01:06 INFO - PROCESS | 26203 | Values: 559.8 585.5 626.1 642.4 660.4 10765.9 11252.7 11325.9 11330.2 12167.3 12459.9 12468.4 12548.3 12550.2 12561.4 729.2 746.1 746.7 746.8 747.5 587.3 602.9 726.1 746.3 753.4 774.1 782.9 782.9 783.1 783.2 772.2 774.2 775.0 775.7 775.9 450.1 457.6 552.6 565.2 571.1 11889.4 11958.7 11996.5 12013.5 12031.0 11556.7 11774.4 12052.8 12191.1 12309.6 9680.1 9818.5 10033.3 11386.3 11523.8 4061.9 4103.2 4106.2 4156.5 4172.1 60252.0 60384.7 61322.0 61679.0 62333.0 10143.9 10254.5 10420.6 10547.8 10725.7 17669.5 17683.9 17687.0 17779.7 17781.8 6275.5 6326.3 6456.7 6515.4 6537.7 3484.8 3496.8 3513.9 3516.9 3561.0 2505.6 2624.7 2626.4 2628.7 2629.6 470.8 507.6 513.5 513.6 538.6 484.2 533.8 551.3 551.5 553.5 7964.6 8092.5 8103.0 8315.7 8478.7 487.2 506.0 509.8 511.3 519.1 3680.9 3842.4 3854.7 3953.6 3965.5 103039.5 103920.0 104973.0 105132.5 107481.5 86899.0 88534.6 89811.6 90410.5 91823.5 78503.0 78508.6 78653.6 78940.1 80036.6 7593.8 7812.9 7821.3 7879.4 7939.5 45031.5 45503.0 45882.3 46660.8 48357.0 64397.0 66194.4 66376.7 66588.3 70392.6 9219.0 9256.7 9391.8 9553.6 9611.9 10200.4 10223.4 10287.3 10346.5 10479.2 9611.7 9867.5 9974.5 10024.7 10096.1 11299.5 11391.8 11480.7 11498.7 11509.3 10711.4 10820.7 10836.9 11686.5 11963.1 9176.0 9274.2 9485.7 9673.9 10308.6 9525.3 9903.7 9951.7 10055.5 10068.8 11:01:06 INFO - PROCESS | 26203 | -------- Summary: end -------- 11:01:06 INFO - PROCESS | 26203 | 11:01:07 INFO - TEST-INFO | 26203: exit 0 11:01:07 INFO - TEST-OK | dromaeo_css | took 1120568ms 11:01:07 INFO - TEST-START | kraken 11:01:07 INFO - operating with platform_type : linux_ 11:01:07 INFO - Initialising browser for kraken test... 11:01:07 INFO - TEST-INFO | started process 26510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7bicTu/profile http://localhost:49063/getInfo.html) 11:01:11 INFO - PROCESS | 26510 | __metrics Screen width/height:1600/1200 11:01:11 INFO - PROCESS | 26510 | colorDepth:24 11:01:11 INFO - PROCESS | 26510 | Browser inner width/height: 1024/697 11:01:11 INFO - PROCESS | 26510 | __metrics 11:01:11 INFO - PROCESS | 26510 | 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" 11:01:11 INFO - PROCESS | 26510 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:12 INFO - PROCESS | 26510 | console.error: PushService: 11:01:12 INFO - PROCESS | 26510 | stateChangeProcessEnqueue: Error transitioning state 11:01:12 INFO - PROCESS | 26510 | UnknownError 11:01:12 INFO - TEST-INFO | 26510: exit 0 11:01:12 INFO - Browser initialized. 11:01:12 INFO - Running cycle 1/1 for kraken test... 11:01:12 INFO - TEST-INFO | started process 26595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7bicTu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:25 INFO - PROCESS | 26595 | RSS: Main: 174784512 11:01:25 INFO - PROCESS | 26595 | 11:01:28 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49063/tests/kraken/driver.html?testName=audio-beat-detection) 11:01:29 INFO - PROCESS | 26595 | RSS: Main: 234254336 11:01:29 INFO - PROCESS | 26595 | 11:01:31 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49063/tests/kraken/driver.html?testName=audio-dft) 11:01:32 INFO - PROCESS | 26595 | RSS: Main: 218705920 11:01:32 INFO - PROCESS | 26595 | 11:01:35 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49063/tests/kraken/driver.html?testName=audio-fft) 11:01:36 INFO - PROCESS | 26595 | RSS: Main: 300568576 11:01:36 INFO - PROCESS | 26595 | 11:01:38 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49063/tests/kraken/driver.html?testName=audio-oscillator) 11:01:39 INFO - PROCESS | 26595 | RSS: Main: 209260544 11:01:39 INFO - PROCESS | 26595 | 11:01:41 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:01:41 INFO - PROCESS | 26595 | RSS: Main: 213258240 11:01:41 INFO - PROCESS | 26595 | 11:01:45 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49063/tests/kraken/driver.html?testName=imaging-darkroom) 11:01:45 INFO - PROCESS | 26595 | RSS: Main: 249946112 11:01:45 INFO - PROCESS | 26595 | 11:01:49 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49063/tests/kraken/driver.html?testName=imaging-desaturate) 11:01:49 INFO - PROCESS | 26595 | RSS: Main: 244723712 11:01:49 INFO - PROCESS | 26595 | 11:01:52 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49063/tests/kraken/driver.html?testName=json-parse-financial) 11:01:53 INFO - PROCESS | 26595 | RSS: Main: 247431168 11:01:53 INFO - PROCESS | 26595 | 11:01:55 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:01:55 INFO - PROCESS | 26595 | RSS: Main: 210968576 11:01:55 INFO - PROCESS | 26595 | 11:01:57 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:01:58 INFO - PROCESS | 26595 | RSS: Main: 218394624 11:01:58 INFO - PROCESS | 26595 | 11:02:00 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:02:01 INFO - PROCESS | 26595 | RSS: Main: 222281728 11:02:01 INFO - PROCESS | 26595 | 11:02:03 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:02:04 INFO - PROCESS | 26595 | RSS: Main: 223264768 11:02:04 INFO - PROCESS | 26595 | 11:02:07 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:02:08 INFO - PROCESS | 26595 | RSS: Main: 220995584 11:02:08 INFO - PROCESS | 26595 | 11:02:09 INFO - PROCESS | 26595 | Cycle 1(1): loaded http://localhost:49063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49063/tests/kraken/driver.html?testName=ai-astar) 11:02:10 INFO - PROCESS | 26595 | RSS: Main: 273399808 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | __start_tp_report 11:02:10 INFO - PROCESS | 26595 | _x_x_mozilla_page_load 11:02:10 INFO - PROCESS | 26595 | _x_x_mozilla_page_load_details 11:02:10 INFO - PROCESS | 26595 | |i|pagename|runs| 11:02:10 INFO - PROCESS | 26595 | |0;ai-astar;112;115;115;115;115;115;114;117;114;115 11:02:10 INFO - PROCESS | 26595 | |1;audio-beat-detection;151;130;130;171;127;129;123;124;160;123 11:02:10 INFO - PROCESS | 26595 | |2;audio-dft;161;160;162;163;161;161;161;162;162;162 11:02:10 INFO - PROCESS | 26595 | |3;audio-fft;77;77;77;106;77;77;77;78;99;77 11:02:10 INFO - PROCESS | 26595 | |4;audio-oscillator;84;84;115;85;84;83;107;84;84;114 11:02:10 INFO - PROCESS | 26595 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;117;117 11:02:10 INFO - PROCESS | 26595 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;146;145 11:02:10 INFO - PROCESS | 26595 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;94;95 11:02:10 INFO - PROCESS | 26595 | |8;json-parse-financial;66;64;64;65;66;66;66;67;65;66 11:02:10 INFO - PROCESS | 26595 | |9;json-stringify-tinderbox;66;68;65;67;67;67;66;67;67;69 11:02:10 INFO - PROCESS | 26595 | |10;stanford-crypto-aes;91;81;91;81;81;82;82;81;82;81 11:02:10 INFO - PROCESS | 26595 | |11;stanford-crypto-ccm;142;134;133;134;132;147;142;132;176;131 11:02:10 INFO - PROCESS | 26595 | |12;stanford-crypto-pbkdf2;173;175;173;169;170;171;173;175;173;173 11:02:10 INFO - PROCESS | 26595 | |13;stanford-crypto-sha256-iterative;68;72;68;69;69;69;72;68;71;67 11:02:10 INFO - PROCESS | 26595 | __end_tp_report 11:02:10 INFO - PROCESS | 26595 | __start_cc_report 11:02:10 INFO - PROCESS | 26595 | _x_x_mozilla_cycle_collect,1923 11:02:10 INFO - PROCESS | 26595 | __end_cc_report 11:02:10 INFO - PROCESS | 26595 | __startTimestamp1474135330197__endTimestamp 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | ------- Summary: start ------- 11:02:10 INFO - PROCESS | 26595 | Number of tests: 14 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.25 (1.1%) stddev-sans-first:0.87 11:02:10 INFO - PROCESS | 26595 | Values: 112.0 115.0 115.0 115.0 115.0 115.0 114.0 117.0 114.0 115.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.00 stddev:17.33 (13.3%) stddev-sans-first:17.61 11:02:10 INFO - PROCESS | 26595 | Values: 151.0 130.0 130.0 171.0 127.0 129.0 123.0 124.0 160.0 123.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 11:02:10 INFO - PROCESS | 26595 | Values: 161.0 160.0 162.0 163.0 161.0 161.0 161.0 162.0 162.0 162.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:10.83 (14.1%) stddev-sans-first:11.32 11:02:10 INFO - PROCESS | 26595 | Values: 77.0 77.0 77.0 106.0 77.0 77.0 77.0 78.0 99.0 77.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:13.69 (16.3%) stddev-sans-first:14.18 11:02:10 INFO - PROCESS | 26595 | Values: 84.0 84.0 115.0 85.0 84.0 83.0 107.0 84.0 84.0 114.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:02:10 INFO - PROCESS | 26595 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:02:10 INFO - PROCESS | 26595 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:02:10 INFO - PROCESS | 26595 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 11:02:10 INFO - PROCESS | 26595 | Values: 66.0 64.0 64.0 65.0 66.0 66.0 66.0 67.0 65.0 66.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 11:02:10 INFO - PROCESS | 26595 | Values: 66.0 68.0 65.0 67.0 67.0 67.0 66.0 67.0 67.0 69.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.08 (5.0%) stddev-sans-first:3.24 11:02:10 INFO - PROCESS | 26595 | Values: 91.0 81.0 91.0 81.0 81.0 82.0 82.0 81.0 82.0 81.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:138.00 stddev:13.67 (9.9%) stddev-sans-first:14.49 11:02:10 INFO - PROCESS | 26595 | Values: 142.0 134.0 133.0 134.0 132.0 147.0 142.0 132.0 176.0 131.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:1.96 (1.1%) stddev-sans-first:2.07 11:02:10 INFO - PROCESS | 26595 | Values: 173.0 175.0 173.0 169.0 170.0 171.0 173.0 175.0 173.0 173.0 11:02:10 INFO - PROCESS | 26595 | 11:02:10 INFO - PROCESS | 26595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.77 (2.6%) stddev-sans-first:1.81 11:02:10 INFO - PROCESS | 26595 | Values: 68.0 72.0 68.0 69.0 69.0 69.0 72.0 68.0 71.0 67.0 11:02:10 INFO - PROCESS | 26595 | -------- Summary: end -------- 11:02:10 INFO - PROCESS | 26595 | 11:02:11 INFO - TEST-INFO | 26595: exit 0 11:02:11 INFO - TEST-OK | kraken | took 64185ms 11:02:11 INFO - SUITE-END | took 1184s 11:02:11 INFO - Completed test suite (00:19:45) 11:02:11 INFO - javascript benchmark 11:02:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.857612831295, 2616.136674897284, 2640.432307053983, 2658.2424009157394, 2670.1055146525914, 4601.079784043188, 4664.230401983677, 4731.90536189276, 4751.192297309457, 4819.397575303087, 4683.555062269087, 4705.200115980283, 4721.976390118053, 4740.857774266778, 4803.303520989463, 4245.596668316505, 4281.05816720321, 4320.654347652196, 4326.048269380732, 4377.912441751163, 4321.438213032301, 4349.195398851222, 4377.168338015783, 4400.207962566737, 4425.336199570074, 4356.477222733292, 4383.298672212447, 4397.12057588482, 4407.405000324947, 4439.667024973124, 4293.742375457483, 4345.044090300129, 4353.73877567347, 4391.143726973241, 4403.581659742319, 4273.166732487166, 4274.444322238121, 4312.719673221262, 4328.11273688893, 4361.6074553290355, 4625.907481850378, 4708.552687494716, 4730.0, 4740.739259340735, 4782.210935195689, 5040.647154699136, 5051.267566202917, 5056.696598204083, 5057.342545469102, 5122.282880396748, 4910.337104490919, 4958.0, 5027.723475208862, 5072.036313100499, 5092.719900405476, 4746.857594272108, 4753.405824271931, 4758.524147585283, 4766.833160839354, 4807.735574543363, 5194.506521880416, 5228.764705588258, 5232.738363081907, 5234.293370395024, 5285.709285989307, 4830.686005409637, 4839.661223714376, 4868.732219727949, 4868.8782780430065, 4883.02339532095, 4984.925226121611, 4989.451160372356, 4989.925151122736, 4990.326305948723, 5029.321041659329, 4929.876753081202, 4936.284238785356, 4940.357753492095, 4985.90028199434, 4998.90002199954, 4851.733154676526, 4901.58336541398, 4907.1167189905445, 4943.826966056243, 4958.429780575208, 4207.242696314632, 4217.304144816071, 4218.388333691598, 4266.189424009428, 4272.829086836554, 3701.981490092532, 3706.258748250361, 3708.8873337998493, 3743.681787048077, 3751.493548370935, 4237.8304867805555, 4280.101178752497, 4402.933955990663, 4409.735415875058, 4445.488768791565, 4962.106820772296, 4999.800007999712, 5000.199968005102, 5026.120428924996, 5064.139096353555, 4333.414988976511, 4334.566543345703, 4338.045629961403, 4348.7390756554705, 4395.780210989437, 4303.33298338758, 4448.866534003985, 4454.10917816438, 4454.643628509712, 4504.752238626907, 4648.744319062416, 4684.578387945101, 4720.291956206596, 4727.550882666142, 4766.45185803637, 4983.925241121314, 4990.4011518618, 4995.575376093073, 5005.849824505271, 5043.420006699276, 4717.056588682346, 4721.409823772028, 4722.622190224843, 4725.952740472551, 4786.569208771228, 4813.590844778233, 4848.660593758545, 4945.925811112908, 4973.900521989468, 4997.525235102659, 5065.164247899203, 5076.670016448919, 5085.7457127144235, 5091.261767043832, 5135.409427915837, 4928.630352723489, 4929.802807887788, 4935.950640493549, 4938.358013458227, 4969.055879382906, 4778.641601879943, 4808.0383923214795, 4860.684055536379, 4896.92654610174, 4975.477574854733, 4855.028994201103, 4862.0, 4863.2461968394955, 4898.975505122452, 4924.581410579997, 4883.413990321184, 4919.926201107058, 4959.9008019838675, 4963.106640804545, 4963.875903102451, 4796.472388037383, 4833.05755377712, 4833.903321933612, 4839.975800120977, 4846.151923413318], "value": 4616.817289201012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6263903184865, 560.5767645427702, 562.8283373571064, 569.427725136238, 571.9190729521205, 27401.862990685044, 29845.403091938177, 29853.253668658293, 38217.42673859887, 39538.0, 40800.59199408005, 40870.0, 40940.18119637613, 41184.58815411852, 41266.0, 7511.286427789365, 7658.65536050879, 7660.463767536275, 7663.923360766376, 7668.501547399429, 7414.59219742914, 7491.475596708233, 7492.812679683025, 7493.73771917983, 7495.063117110361, 7511.661975211101, 7551.433642476809, 7554.69781208751, 7557.47097703161, 7566.20554841742, 7467.962660186691, 7502.887456688154, 7509.436792240604, 7516.947627332123, 7520.0, 7565.13001004886, 7633.0458692663415, 7633.274838890296, 7641.541507509512, 7642.082950045974, 37163.0, 37556.81221593902, 37574.0, 37586.81206593977, 37612.811935940146, 2681.6781986161786, 2704.1752265559, 2851.201663534214, 3113.719765221141, 3334.3498017886523, 25079.49841003188, 29408.264793380124, 30163.698363016527, 30286.69713302883, 30323.848380758176, 3064.8620812063286, 3152.5271209318557, 3258.560094387251, 3315.552400425936, 3337.9666203337897, 255123.0, 257670.0, 257731.0, 258567.0, 258570.0, 30878.22804429907, 31704.0, 52926.0, 53516.197257041174, 53591.73204133954, 32300.515492267634, 32665.18337041593, 32879.34241315208, 32901.50647740286, 32918.0, 11647.76704465906, 11832.940835295769, 11852.644420667393, 11875.0, 11916.16586838913, 9507.096825801538, 9570.712878613653, 9586.28102892272, 9591.232701383873, 9601.759956001157, 7711.652975616111, 7789.532628042222, 7839.490433121829, 7841.960790196013, 7845.254700803414, 2977.687342828972, 2987.985060074686, 3028.212664707192, 3042.6196725409322, 3069.4014667139695, 832.3299743706253, 851.29342645604, 879.0, 885.2961895293257, 919.1865199298535, 27209.183724488295, 27795.722042779315, 28251.0, 28412.857935710188, 28457.715422845507, 854.9145085491401, 892.7678803511134, 940.8682784410188, 941.2799208605422, 947.3463310315998, 13750.587482375544, 14760.619690154923, 14775.778363324558, 14940.477083302032, 15177.24113794306, 382615.0, 386829.0, 387434.0, 387742.0, 388073.0, 47331.526684732715, 47664.28503572449, 47743.522564773906, 47766.761166193945, 47844.76077619589, 1019.2152042926905, 1058.5130839813771, 1112.4437781109445, 1130.1580322659672, 1147.8106112491512, 27275.454490910466, 28382.0, 29284.853575731984, 29530.114096577137, 29739.702602974558, 40344.798276009606, 40747.18505629811, 40747.59252407438, 40851.591484084776, 40945.38581921214, 274350.0, 275701.0, 275913.0, 276293.0, 276665.0, 22089.66865497051, 22814.42963925915, 38715.612843872324, 39209.215815684096, 39653.80173099116, 39067.41398878962, 42451.3632295522, 42554.36168457538, 43651.781741091094, 44273.77863110664, 36461.45307820332, 36484.60188846272, 37281.44077838889, 37608.811955940044, 38244.80877595594, 36527.817360913024, 36699.63300366962, 36862.078448039014, 37281.44077838889, 37489.250214995, 35364.0, 35728.10679733028, 35787.0, 35996.64003360038, 35999.0, 31164.0, 33503.66496335006, 33720.0, 33854.322913542084, 33859.661403386635, 25021.12426065079, 25230.74769252284, 25305.0, 26055.0, 26263.0], "value": 16036.237908286657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.91526203187163, 329.78234365318895, 350.18057744876984, 350.61957775813244, 358.1869157013579, 10848.0, 11952.282863028224, 15174.089554626717, 15642.84357156428, 16647.084410357427, 16312.0, 16413.261403236855, 16441.753373699405, 16606.335746570123, 16676.249568769403, 4472.41858558387, 4912.238603016538, 5107.978404319132, 5108.693478391308, 5110.974445127769, 5933.821985340447, 6037.124616930542, 6038.124471951564, 6050.122732203828, 6094.268687757475, 5878.177055212273, 5892.116182572606, 6006.699665016754, 6048.516118710492, 6050.03199488082, 5925.170476133323, 5936.28764548257, 5955.940440595582, 5958.940410595882, 5983.461488466037, 4557.886052848672, 4799.424069111729, 4838.637102217348, 4911.312416261726, 5184.481551844823, 11286.492107855167, 11499.942500287445, 11515.827262591069, 11524.711882202928, 17871.642567148585, 1745.8166892476233, 1763.8765286429955, 1794.9675203464521, 2011.0, 2231.475603233239, 9054.637814487412, 9287.860682089775, 10198.541065652063, 11753.0, 13501.2574308413, 1718.5274049636325, 1721.535185499908, 1753.8070812210647, 1756.8331008554294, 1775.6271183051574, 55369.72315138399, 59924.0, 68097.65951170262, 69858.65070674664, 72365.27634723637, 9642.0, 9808.831246720116, 9862.901370986341, 10058.849117263248, 10060.647877324405, 13529.59411217665, 13538.0, 13543.59369218925, 13567.118137321042, 13576.253306068063, 6574.80275591733, 6848.589084654936, 6891.173059232924, 6897.7240910363025, 6981.825454363681, 6505.316941721051, 6514.250861150934, 6635.8009259722285, 6675.566088204251, 6722.731090756315, 4031.879043628696, 4116.485439320085, 4131.5248746394545, 4175.728577642504, 4299.505556861001, 1785.9107044647715, 1786.490850107713, 1795.5062357851434, 1831.1851226204212, 1859.2284202056267, 796.8246985663145, 797.2824457987741, 821.4332110843499, 833.5415521463171, 851.4720873058743, 15431.074135551678, 16253.512394627944, 16411.753823692656, 16654.16729163537, 17331.133443327784, 803.6303300481727, 816.7835523586255, 833.7707130539151, 834.5785378383878, 892.4199270474244, 8666.306695464347, 9138.68014619485, 9545.52272386378, 9637.976743837698, 9703.66037188695, 374637.0, 382773.0, 388125.0, 393898.0, 398345.0, 77258.22741772623, 77587.61206193933, 82173.58913205516, 82695.17304826995, 82699.0, 867.509856930832, 883.7702197428587, 924.5515924776478, 928.1692884868005, 936.9344145909721, 14301.642458938193, 15160.620984475476, 15781.132037738034, 15925.840741592436, 16146.838531615003, 35080.47379289364, 36783.63216367909, 39034.80482597569, 41027.0, 41762.37356439717, 50619.0, 53148.46851531435, 53846.730766345914, 54515.72742136264, 54877.0, 6961.825954351182, 7213.963930180315, 7334.156571994289, 7579.393648507996, 7617.581033043236, 10892.405506182782, 11063.668089957315, 11114.722131946766, 11316.0, 11655.53377864876, 9944.254180936314, 9953.651622193189, 10247.128994035591, 10411.21915856329, 10737.570497180337, 9911.950440248042, 9987.700368988943, 10187.592496300362, 10486.161107111566, 10595.841062383915, 9798.265130115413, 10173.186145108522, 10281.074703276741, 10424.791504170025, 10644.361338319726, 7091.822704432224, 7118.074650295428, 7297.160826504807, 7534.623268836646, 8046.074701409413, 9301.395409298373, 9621.807563848824, 9769.609215631295, 9787.33135147488, 9900.158486528726], "value": 8009.33274839156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.4775098956452, 1274.9490020399185, 1329.65428988463, 1353.3503918119302, 1607.3731244814524, 6501.642409667466, 7240.094988126484, 7522.247775222475, 7543.245675432454, 7758.49569777964, 7627.199144089874, 7695.5382677039415, 7699.230076992298, 7702.730404435846, 7704.53772773634, 2085.8644188127723, 2112.1868080788854, 2113.2709215320688, 2113.471632091977, 2114.7990940860595, 2061.5773766377856, 2095.235239137719, 2114.164904862578, 2115.3971118231307, 2123.4266747978036, 2070.6272870883236, 2073.3365323096614, 2083.1771450277133, 2084.7289852319177, 2087.2485905074236, 2085.8748475091465, 2089.5716378142442, 2091.98954005229, 2092.455961450034, 2093.5708179823177, 2055.8869262190574, 2062.7730949595534, 2095.916163353464, 2096.2767845093417, 2102.7897210278848, 7435.814104647373, 7595.088589369311, 7633.580153091578, 7714.267144621252, 7716.922830771677, 4209.200251952119, 4326.935095973563, 4347.760873151976, 4349.151915376503, 4352.325389564622, 2719.0, 2804.845733484678, 2849.529827578447, 2850.2446851584345, 2856.48583255014, 910.8588168833842, 916.5829547555846, 932.4265576670299, 936.7330310861372, 938.7183844846587, 10096.242781791321, 10187.235957303232, 10230.181585473145, 10241.539130739135, 10245.129164021067, 3613.855445782192, 3758.680512156497, 3859.0931131184147, 3888.9611103889165, 3916.784576848244, 8067.0722866871065, 8088.595570221465, 8097.190280971856, 8101.594920254081, 8103.797405064803, 4170.124273902454, 4198.454200953856, 4201.810918508674, 4214.072903961123, 4216.852410165629, 3358.328334333143, 3478.4260597001717, 3857.517810273716, 3922.627350401707, 3943.901402464904, 3302.7192688621735, 3359.3617212729505, 3454.7581669283413, 3459.7232221422228, 3460.602030766444, 1013.6654903881702, 1018.6332920148741, 1033.2302434686208, 1038.657243109772, 1039.7211429941215, 721.8844984802406, 723.7322190789337, 743.2344684974485, 752.3116348541133, 767.244264399566, 5017.046761115376, 5035.546800787946, 5100.081985242692, 5194.714290713971, 5291.788328466895, 761.1209053543166, 831.0193971114022, 840.684743221292, 846.6232526525637, 851.3189448441223, 3170.793898396597, 3291.391092647868, 3390.711789497871, 3448.9827550862087, 3553.022918697327, 9091.727248182566, 9538.761530961643, 9553.04469553039, 9560.0, 9568.234541236685, 8830.293576513863, 9346.626134954662, 9475.90524094764, 9514.28642851789, 9516.429014259167, 7118.28817118284, 7291.08861392326, 7323.523970941872, 7328.67020984057, 7331.633418329169, 5272.499112584298, 5454.072807622634, 5499.450054994629, 5507.807226747044, 5610.943890561042, 8432.83134337322, 8668.263197628272, 8820.64717411322, 8830.249428798625, 8874.0, 8784.979454725577, 8985.415947963362, 9040.547972601213, 9053.818923621622, 9112.544372781467, 5804.912926306193, 6020.0, 6715.563488373436, 6840.657967101525, 6856.417204537471, 6774.254831968381, 7069.257727938492, 7083.610401427971, 7307.561546307238, 7310.0, 6418.582792118497, 6491.578047426902, 6580.374864387875, 6628.105205797156, 6839.974003899455, 6701.497387696039, 6709.4632429404555, 6758.7296508139125, 6767.593944363354, 6805.523613347018, 5980.401959803985, 6068.51451883857, 6075.362086980804, 6077.301110372364, 6080.148779170831, 4390.934135987899, 4400.229959757094, 4477.910441791211, 4524.660650451295, 4528.592426681615, 4413.691041627184, 4451.5771001756075, 4455.7994890229365, 4462.107578484381, 4539.477960034506], "value": 3958.4867563172934, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.8940202722965, 285.64865215784596, 286.24431500837807, 286.30999291706985, 295.94672958867403, 4752.881177970552, 4786.56920877121, 4789.233722604384, 4793.400824896888, 4813.157697402949, 4712.85861424157, 4718.764061796905, 4724.102420540095, 4730.526947305268, 4743.928841067387, 3551.307495038462, 3578.982105089484, 3642.380795264798, 3682.263547290539, 3731.104534911629, 3709.5548534175937, 3722.4230244312175, 3723.664870161685, 3733.0, 3733.757305775116, 3675.117971686803, 3675.9448608270895, 3682.6501482359267, 3699.260147970403, 3699.519062521882, 3483.303339332131, 3557.1107223194203, 3607.24247907941, 3704.184949374814, 3715.256948610289, 3277.524758909945, 3279.884839154699, 3290.0, 3291.3417316536547, 3294.357600267949, 4616.907661846744, 4619.637207023936, 4622.884427889296, 4629.629629629621, 4631.675782695213, 3898.571157172709, 4146.979265103685, 4240.257954857888, 4247.129338485603, 4247.745135291892, 4909.410870695504, 4909.509049095098, 4913.852584422473, 4930.630202734809, 4944.258361245806, 3475.669811367916, 3481.56480439945, 3493.2489514754448, 3494.318607871466, 3500.1074725944977, 5059.16523773577, 5177.301064356301, 5202.739863006835, 5214.608904332153, 5214.869628259324, 3533.9293214135573, 3552.5736911570775, 3555.6977656898935, 3566.3937130687846, 3569.6787289144104, 3621.8229075550553, 3625.22364041623, 3631.3100510902846, 3636.0, 3656.689181419556, 4117.97941010293, 4130.339145736668, 4143.7928103594695, 4144.7513149211145, 4145.440365550612, 4666.883327916829, 4859.416869975626, 4937.5556199942175, 4938.407391113089, 4947.975260123676, 1211.1824518450012, 1230.6185082624236, 1232.4269214815154, 1233.1183204009176, 1239.1573729863778, 766.9731559395506, 790.6481615681082, 797.1351084073845, 804.5253300552702, 808.6563210635574, 3982.2234664240773, 4221.894452638709, 4319.719218250803, 4329.696921215547, 4431.135928493977, 5085.160948443539, 5100.770465329069, 5109.675097830478, 5113.258577506241, 5143.177091665316, 4425.712328698624, 4440.444944381952, 4453.376527286183, 4459.5986361227, 4467.776611169428, 2613.882375293116, 2651.840889546633, 2664.720204378551, 2670.1588999465107, 2670.692870319899, 4787.808487660524, 4807.735574543433, 4824.0834241494, 4828.589569886599, 4833.806647734122, 5188.870278242998, 5203.115470370046, 5206.245094461282, 5214.843554693365, 5217.0, 4673.205555055649, 4790.473047964721, 4816.349792778, 4825.95174048255, 4827.758612069452, 5077.441481437113, 5088.160453525127, 5095.363079615048, 5101.92347114801, 5104.744762761921, 4962.057209130254, 4969.751512424436, 5003.799848006039, 5004.974975125101, 5015.498450154955, 4568.314752787109, 4745.501722319244, 4769.546893045155, 4774.3315935769715, 4813.422389313305, 3590.7666001709804, 3593.155608431964, 3594.8562057517406, 3595.06528302638, 3604.13500759821, 5070.721110338966, 5135.563477104339, 5137.255098010843, 5148.279240906201, 5158.406783219978, 4719.961608446137, 4944.604431645532, 4960.627952903475, 4973.229149481836, 5001.624878134082, 4945.109880221451, 4956.553910148104, 4961.627877909099, 4964.560277519479, 4974.328465657235, 4887.877803054952, 4897.946941407615, 4903.583195428429, 4904.852854414374, 4907.656464047483, 4697.976510117564, 4726.409198850144, 4921.769557610597, 4965.106280869478, 4981.825636102719, 4667.906641867075, 4773.689710168828, 4811.302361157683, 4852.19938710123, 4852.344933433941], "value": 3711.4844991280597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8012705489551, 585.5491271720775, 626.1046703214402, 642.4282388674079, 660.3990368764426, 10765.892341076596, 11252.718682032953, 11325.943370283147, 11330.150238732098, 12167.330796806173, 12459.937700311508, 12468.438920248587, 12548.309842958633, 12550.184238024545, 12561.434735436904, 729.2343039808194, 746.0599644448007, 746.6640011994597, 746.7796999885047, 747.495440577608, 587.3451102021259, 602.9276486821587, 726.0670038999887, 746.3320328306163, 753.3897542990168, 774.1484367196067, 782.8708263136575, 782.8708263136575, 783.0837919634014, 783.1776634533745, 772.169917338863, 774.175503089211, 774.9925097373421, 775.7207405334075, 775.8836174573803, 450.1357393803904, 457.569884308752, 552.6048875054315, 565.197419664078, 571.0663065887263, 11889.405529723479, 11958.701032474171, 11996.460159292852, 12013.459394327276, 12031.037516998707, 11556.653300401002, 11774.411279435993, 12052.819207711891, 12191.146619736623, 12309.56916507918, 9680.128788409076, 9818.45998470084, 10033.297669163161, 11386.259893106922, 11523.827142592867, 4061.939070913939, 4103.158852435274, 4106.2198182345255, 4156.521999970012, 4172.08214192877, 60252.0, 60384.698076509776, 61322.0, 61679.0, 62333.0, 10143.949280253551, 10254.48727563619, 10420.635277765241, 10547.789044219073, 10725.731856703489, 17669.469915902544, 17683.911580442014, 17687.0, 17779.73330400019, 17781.822181778018, 6275.529335299871, 6326.2724786649205, 6456.677166141768, 6515.446187074152, 6537.673116344259, 3484.790912545255, 3496.7727097738566, 3513.894583162509, 3516.9120771980906, 3561.0385195996937, 2505.6241563765216, 2624.6719160104985, 2626.448445826398, 2628.6976997645133, 2629.618705287761, 470.7787339950218, 507.58124547248667, 513.4942082049179, 513.599392473871, 538.6364204162174, 484.2228223700909, 533.7918211897363, 551.2585572405109, 551.5119119579201, 553.5303768494654, 7964.646010178283, 8092.473989190684, 8103.0, 8315.667373305, 8478.74563763088, 487.1961263914569, 505.96205284603803, 509.80882169186555, 511.29186077282486, 519.1460048220731, 3680.871169509054, 3842.423636454554, 3854.6530812227033, 3953.5651078381356, 3965.524137103566, 103039.484802577, 103920.0, 104973.0, 105132.47433762782, 107481.46259268654, 86899.0, 88534.55732721424, 89811.55094224487, 90410.54794725984, 91823.5408822965, 78503.0, 78508.6074569635, 78653.60673196711, 78940.1059894006, 80036.59981700055, 7593.848123037398, 7812.92187078122, 7821.335186508983, 7879.369650427838, 7939.523628582304, 45031.54968450274, 45503.0, 45882.311765324215, 46660.766696166305, 48357.0, 64397.0, 66194.38764542139, 66376.6681166591, 66588.33411665821, 70392.64803675949, 9218.953905230432, 9256.722298330791, 9391.765205869908, 9553.61785528571, 9611.903880961381, 10200.38797672142, 10223.386596804216, 10287.331323463952, 10346.482675866328, 10479.214058945458, 9611.69275832743, 9867.457289849128, 9974.451405172495, 10024.699259022242, 10096.141827944413, 11299.548018079513, 11391.829122563002, 11480.712982175512, 11498.655040348804, 11509.251898626562, 10711.357318560911, 10820.729481763019, 10836.891631083588, 11686.532538698697, 11963.102767292314, 9175.954120229357, 9274.165325120503, 9485.715428537154, 9673.903260967581, 10308.639197628347, 9525.333226674065, 9903.702888913343, 9951.651692190739, 10055.49722513886, 10068.798624027624], "value": 6279.08126962264, "unit": "score"}], "name": "dromaeo_css", "value": 6161.367772996451, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 117.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 130.0, 171.0, 127.0, 129.0, 123.0, 124.0, 160.0, 123.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 106.0, 77.0, 77.0, 77.0, 78.0, 99.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 85.0, 84.0, 83.0, 107.0, 84.0, 84.0, 114.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 69.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 81.0, 91.0, 81.0, 81.0, 82.0, 82.0, 81.0, 82.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 133.0, 134.0, 132.0, 147.0, 142.0, 132.0, 176.0, 131.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 169.0, 170.0, 171.0, 173.0, 175.0, 173.0, 173.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 69.0, 69.0, 69.0, 72.0, 68.0, 71.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1543.5, "alertThreshold": 2.0}]} 11:02:11 INFO - Return code: 0 11:02:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:02:12 INFO - # TBPL SUCCESS # 11:02:12 INFO - Running post-action listener: _resource_record_post_action 11:02:12 INFO - [mozharness: 2016-09-17 18:02:12.009352Z] Finished run-tests step (success) 11:02:12 INFO - Running post-run listener: _resource_record_post_run 11:02:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 391569408; Read time: 0; Write time: 267364 11:02:12 INFO - TinderboxPrint: CPU usage
13.0% 11:02:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:02:12 INFO - TinderboxPrint: I/O write bytes / time
391,569,408 / 267,364 11:02:12 INFO - TinderboxPrint: CPU idle
8,331.0 (86.9%) 11:02:12 INFO - TinderboxPrint: CPU user
1,202.6 (12.5%) 11:02:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:02:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99721216; Read time: 0; Write time: 85860 11:02:12 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 291848192; Read time: 0; Write time: 181504 11:02:12 INFO - Running post-run listener: _upload_blobber_files 11:02:12 INFO - Blob upload gear active. 11:02:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:02:12 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:02:12 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:02:12 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:02:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:13 INFO - (blobuploader) - INFO - Done attempting. 11:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:17 INFO - (blobuploader) - INFO - Done attempting. 11:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:18 INFO - (blobuploader) - INFO - Done attempting. 11:02:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:18 INFO - Return code: 0 11:02:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a54f1b23ad0c752e201dc39067ef15ba7675c670f0d8ec7ade782d259ba7b85f6a70362f92df8e071b569e7c210b283849bd9c3c3c31247cbd17db0841956873", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f70bbe4528f5c50c18e236e8e65e09d4d1275bc6f10b5f1f3c9aca5a4269e99c8d3ce5d9521c2573fc76bfc095c2fe82bb77ab20048c9cd98162bf179a70679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5eefd66680541bba15050f765184851ac7af966254f46ff06955d0d3e6517fc15a45f6910674b26219333589f14277d8e6d1a34f28a81936b7ba6fa362ad65b"} 11:02:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:18 INFO - Contents: 11:02:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a54f1b23ad0c752e201dc39067ef15ba7675c670f0d8ec7ade782d259ba7b85f6a70362f92df8e071b569e7c210b283849bd9c3c3c31247cbd17db0841956873", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f70bbe4528f5c50c18e236e8e65e09d4d1275bc6f10b5f1f3c9aca5a4269e99c8d3ce5d9521c2573fc76bfc095c2fe82bb77ab20048c9cd98162bf179a70679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5eefd66680541bba15050f765184851ac7af966254f46ff06955d0d3e6517fc15a45f6910674b26219333589f14277d8e6d1a34f28a81936b7ba6fa362ad65b"} 11:02:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:02:18 INFO - Copying logs to upload dir... 11:02:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:02:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.593099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-17 11:02:18.378352) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 11:02:18.382176) ========= 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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 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/a54f1b23ad0c752e201dc39067ef15ba7675c670f0d8ec7ade782d259ba7b85f6a70362f92df8e071b569e7c210b283849bd9c3c3c31247cbd17db0841956873", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f70bbe4528f5c50c18e236e8e65e09d4d1275bc6f10b5f1f3c9aca5a4269e99c8d3ce5d9521c2573fc76bfc095c2fe82bb77ab20048c9cd98162bf179a70679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5eefd66680541bba15050f765184851ac7af966254f46ff06955d0d3e6517fc15a45f6910674b26219333589f14277d8e6d1a34f28a81936b7ba6fa362ad65b"} 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.011253 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/a54f1b23ad0c752e201dc39067ef15ba7675c670f0d8ec7ade782d259ba7b85f6a70362f92df8e071b569e7c210b283849bd9c3c3c31247cbd17db0841956873", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f70bbe4528f5c50c18e236e8e65e09d4d1275bc6f10b5f1f3c9aca5a4269e99c8d3ce5d9521c2573fc76bfc095c2fe82bb77ab20048c9cd98162bf179a70679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a5eefd66680541bba15050f765184851ac7af966254f46ff06955d0d3e6517fc15a45f6910674b26219333589f14277d8e6d1a34f28a81936b7ba6fa362ad65b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 11:02:18.407947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 11:02:18.408325) ========= 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=923d835db2ba3686ebe126b700000192-1474134095.29255-1142681875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 11:02:18.494088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 11:02:18.494498) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 11:02:18.494960) ========= ========= Total master_lag: 0.17 =========