builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1481191736.67 results: success (0) buildid: 20161208020803 builduid: 907d7fc1c32a4cf0b6fae35fd2c93d48 revision: 82aeade4d0073cd0c2da2d61543fe0a50430cfbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:56.670780) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:56.671257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:56.671561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:56.686173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:56.686451) ========= 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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 02:08:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-12-08 02:08:57 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.315042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:57.015364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:57.015899) ========= 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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:08:57.065288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-08 02:08:57.065641) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 82aeade4d0073cd0c2da2d61543fe0a50430cfbb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 82aeade4d0073cd0c2da2d61543fe0a50430cfbb --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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 02:08:57,711 truncating revision to first 12 chars 2016-12-08 02:08:57,711 Setting DEBUG logging. 2016-12-08 02:08:57,711 attempt 1/10 2016-12-08 02:08:57,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/82aeade4d007?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 02:09:00,352 unpacking tar archive at: mozilla-inbound-82aeade4d007/testing/mozharness/ program finished with exit code 0 elapsedTime=3.716062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-08 02:09:00.798942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 02:09:00.799222) ========= script_repo_revision: 82aeade4d0073cd0c2da2d61543fe0a50430cfbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 02:09:00.799599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 02:09:00.799897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 02:09:00.809881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-08 02:09:00.810256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:09:01 INFO - MultiFileLogger online at 20161208 02:09:01 in /builds/slave/test 02:09:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:09:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:01 INFO - {'append_to_log': False, 02:09:01 INFO - 'base_work_dir': '/builds/slave/test', 02:09:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:09:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:01 INFO - 'branch': 'Mozilla-Inbound', 02:09:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:01 INFO - 'config_files': ('talos/linux_config.py',), 02:09:01 INFO - 'default_actions': ('clobber', 02:09:01 INFO - 'read-buildbot-config', 02:09:01 INFO - 'download-and-extract', 02:09:01 INFO - 'populate-webroot', 02:09:01 INFO - 'create-virtualenv', 02:09:01 INFO - 'install', 02:09:01 INFO - 'run-tests'), 02:09:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:01 INFO - 'download_minidump_stackwalk': True, 02:09:01 INFO - 'download_symbols': 'ondemand', 02:09:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:01 INFO - 'installer_path': 'installer.exe', 02:09:01 INFO - 'log_level': 'info', 02:09:01 INFO - 'log_name': 'talos', 02:09:01 INFO - 'log_to_console': True, 02:09:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:09:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:09:01 INFO - 'opt_config_files': (), 02:09:01 INFO - 'pip_index': False, 02:09:01 INFO - 'sps_profile': False, 02:09:01 INFO - 'sps_profile_interval': 0, 02:09:01 INFO - 'suite': 'dromaeojs-e10s', 02:09:01 INFO - 'system_bits': '32', 02:09:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:01 INFO - 'title': 'talos-linux64-ix-052', 02:09:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:01 INFO - 'use_talos_json': True, 02:09:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:01 INFO - 'work_dir': 'build'} 02:09:01 INFO - [mozharness: 2016-12-08 10:09:01.556807Z] Running clobber step. 02:09:01 INFO - Running pre-action listener: _resource_record_pre_action 02:09:01 INFO - Running main action method: clobber 02:09:01 INFO - rmtree: /builds/slave/test/build 02:09:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:02 INFO - Running post-action listener: _resource_record_post_action 02:09:02 INFO - [mozharness: 2016-12-08 10:09:02.653757Z] Finished clobber step (success) 02:09:02 INFO - [mozharness: 2016-12-08 10:09:02.653857Z] Running read-buildbot-config step. 02:09:02 INFO - Running pre-action listener: _resource_record_pre_action 02:09:02 INFO - Running main action method: read_buildbot_config 02:09:02 INFO - Using buildbot properties: 02:09:02 INFO - { 02:09:02 INFO - "project": "", 02:09:02 INFO - "product": "firefox", 02:09:02 INFO - "script_repo_revision": "production", 02:09:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:09:02 INFO - "repository": "", 02:09:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:09:02 INFO - "buildid": "20161208020803", 02:09:02 INFO - "stage_platform": "linux64-pgo", 02:09:02 INFO - "basedir": "/builds/slave/test", 02:09:02 INFO - "buildnumber": 1728, 02:09:02 INFO - "platform": "ubuntu64_hw", 02:09:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:09:02 INFO - "slavebuilddir": "test", 02:09:02 INFO - "branch": "mozilla-inbound", 02:09:02 INFO - "revision": "82aeade4d0073cd0c2da2d61543fe0a50430cfbb", 02:09:02 INFO - "slavename": "talos-linux64-ix-052", 02:09:02 INFO - "builduid": "907d7fc1c32a4cf0b6fae35fd2c93d48", 02:09:02 INFO - "repo_path": "integration/mozilla-inbound" 02:09:02 INFO - } 02:09:02 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:09:02 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 02:09:02 INFO - Running post-action listener: _resource_record_post_action 02:09:02 INFO - [mozharness: 2016-12-08 10:09:02.656237Z] Finished read-buildbot-config step (success) 02:09:02 INFO - [mozharness: 2016-12-08 10:09:02.656325Z] Running download-and-extract step. 02:09:02 INFO - Running pre-action listener: _resource_record_pre_action 02:09:02 INFO - Running main action method: download_and_extract 02:09:02 INFO - mkdir: /builds/slave/test/build/tests 02:09: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')]} 02:09:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:09:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:09:02 INFO - Downloaded 1361 bytes. 02:09:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:09:02 INFO - Using the following test package requirements: 02:09:02 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:09:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:09:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'jsshell-linux-x86_64.zip'], 02:09:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:09:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:09:02 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:09:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:09:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:09:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:09:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:09:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:09:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:09:03 INFO - Expected file size: 21781583 02:09:03 INFO - Obtained file size: 21781583 02:09:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:09:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:09:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:09:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:09:07 INFO - Expected file size: 21781583 02:09:07 INFO - Obtained file size: 21781583 02:09:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:09:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:09:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:09:11 INFO - Expected file size: 14409734 02:09:11 INFO - Obtained file size: 14409734 02:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:09:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:09:13 INFO - Downloaded 59842110 bytes. 02:09:13 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:09:13 INFO - mkdir: /builds/slave/test/properties 02:09:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:13 INFO - Contents: 02:09:13 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:09:13 INFO - Running post-action listener: _resource_record_post_action 02:09:13 INFO - Running post-action listener: set_extra_try_arguments 02:09:13 INFO - [mozharness: 2016-12-08 10:09:13.772135Z] Finished download-and-extract step (success) 02:09:13 INFO - [mozharness: 2016-12-08 10:09:13.772395Z] Running populate-webroot step. 02:09:13 INFO - Running pre-action listener: _resource_record_pre_action 02:09:13 INFO - Running main action method: populate_webroot 02:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:13 INFO - '--tppagecycles', 02:09:13 INFO - '7'], 02:09:13 INFO - 'tests': ['tsvgm']}}, 02:09:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:09:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:09:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['damp', 'tps']}, 02:09:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'tests': ['damp', 'tps']}, 02:09:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['dromaeo_dom']}, 02:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['basic_compositor_video']}, 02:09:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:09:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['a11yr', 02:09:13 INFO - 'ts_paint', 02:09:13 INFO - 'tpaint', 02:09:13 INFO - 'sessionrestore', 02:09:13 INFO - 'sessionrestore_no_auto_restore', 02:09:13 INFO - 'tabpaint']}, 02:09:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['tsvgx', 02:09:13 INFO - 'tsvgr_opacity', 02:09:13 INFO - 'tart', 02:09:13 INFO - 'tscrollx', 02:09:13 INFO - 'cart', 02:09:13 INFO - 'tsvg_static']}, 02:09:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:09:13 INFO - 'tsvgr_opacity', 02:09:13 INFO - 'tart', 02:09:13 INFO - 'tscrollx', 02:09:13 INFO - 'cart', 02:09:13 INFO - 'tsvg_static']}, 02:09:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'talos_options': ['--disable-e10s'], 02:09:13 INFO - 'tests': ['tp5o']}, 02:09:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:09:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'talos_options': ['--disable-e10s', 02:09:13 INFO - '--xperf_path', 02:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:13 INFO - 'tests': ['tp5n']}, 02:09:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:09:13 INFO - 'talos_options': ['--xperf_path', 02:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:13 INFO - 'tests': ['tp5n']}}, 02:09:13 INFO - 'talos.zip': {'path': '', 02:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:13 INFO - Running post-action listener: _resource_record_post_action 02:09:13 INFO - [mozharness: 2016-12-08 10:09:13.791015Z] Finished populate-webroot step (success) 02:09:13 INFO - [mozharness: 2016-12-08 10:09:13.791106Z] Running create-virtualenv step. 02:09:13 INFO - Running pre-action listener: _resource_record_pre_action 02:09:13 INFO - Running main action method: create_virtualenv 02:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:13 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 02:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:13 INFO - Using real prefix '/usr' 02:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:16 INFO - Installing pip.................done. 02:09:16 INFO - Return code: 0 02:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:09:16 INFO - Reading from file tmpfile_stdout 02:09:16 INFO - Output received: 02:09:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:09:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:16 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')]} 02:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:16 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')]} 02:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:16 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:16 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 02:09:16 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 02:09:16 INFO - Using env: {'DISPLAY': ':0', 02:09:16 INFO - 'HOME': '/home/cltbld', 02:09:16 INFO - 'LANG': 'en_US.UTF-8', 02:09:16 INFO - 'LANGUAGE': 'en_US:en', 02:09:16 INFO - 'LOGNAME': 'cltbld', 02:09:16 INFO - 'MAIL': '/var/mail/cltbld', 02:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:16 INFO - 'MOZ_NO_REMOTE': '1', 02:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:16 INFO - 'NO_EM_RESTART': '1', 02:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:16 INFO - 'PWD': '/builds/slave/test', 02:09:16 INFO - 'SHELL': '/bin/bash', 02:09:16 INFO - 'SHLVL': '1', 02:09:16 INFO - 'TERM': 'linux', 02:09:16 INFO - 'TMOUT': '86400', 02:09:16 INFO - 'USER': 'cltbld', 02:09:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:16 INFO - '_': '/tools/buildbot/bin/python'} 02:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:09:17 INFO - Cleaning up... 02:09:17 INFO - Return code: 0 02:09:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:09:17 INFO - Using env: {'DISPLAY': ':0', 02:09:17 INFO - 'HOME': '/home/cltbld', 02:09:17 INFO - 'LANG': 'en_US.UTF-8', 02:09:17 INFO - 'LANGUAGE': 'en_US:en', 02:09:17 INFO - 'LOGNAME': 'cltbld', 02:09:17 INFO - 'MAIL': '/var/mail/cltbld', 02:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:17 INFO - 'MOZ_NO_REMOTE': '1', 02:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:17 INFO - 'NO_EM_RESTART': '1', 02:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:17 INFO - 'PWD': '/builds/slave/test', 02:09:17 INFO - 'SHELL': '/bin/bash', 02:09:17 INFO - 'SHLVL': '1', 02:09:17 INFO - 'TERM': 'linux', 02:09:17 INFO - 'TMOUT': '86400', 02:09:17 INFO - 'USER': 'cltbld', 02:09:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:17 INFO - '_': '/tools/buildbot/bin/python'} 02:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:17 INFO - Downloading/unpacking psutil>=3.1.1 02:09:17 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 02:09:17 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 02:09:17 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 02:09:17 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 02:09:17 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 02:09:17 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 02:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:23 INFO - Installing collected packages: psutil 02:09:23 INFO - Running setup.py install for psutil 02:09:23 INFO - building 'psutil._psutil_linux' extension 02:09:23 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 02:09:24 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 02:09:24 INFO - building 'psutil._psutil_posix' extension 02:09:24 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 02:09:24 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 02:09:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:24 INFO - Successfully installed psutil 02:09:24 INFO - Cleaning up... 02:09:24 INFO - Return code: 0 02:09:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:09:24 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')]} 02:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:24 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')]} 02:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:24 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:24 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 02:09:24 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 02:09:24 INFO - Using env: {'DISPLAY': ':0', 02:09:24 INFO - 'HOME': '/home/cltbld', 02:09:24 INFO - 'LANG': 'en_US.UTF-8', 02:09:24 INFO - 'LANGUAGE': 'en_US:en', 02:09:24 INFO - 'LOGNAME': 'cltbld', 02:09:24 INFO - 'MAIL': '/var/mail/cltbld', 02:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:24 INFO - 'MOZ_NO_REMOTE': '1', 02:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:24 INFO - 'NO_EM_RESTART': '1', 02:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:24 INFO - 'PWD': '/builds/slave/test', 02:09:24 INFO - 'SHELL': '/bin/bash', 02:09:24 INFO - 'SHLVL': '1', 02:09:24 INFO - 'TERM': 'linux', 02:09:24 INFO - 'TMOUT': '86400', 02:09:24 INFO - 'USER': 'cltbld', 02:09:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:24 INFO - '_': '/tools/buildbot/bin/python'} 02:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:09:28 INFO - Installing collected packages: mozsystemmonitor 02:09:28 INFO - Running setup.py install for mozsystemmonitor 02:09:28 INFO - Successfully installed mozsystemmonitor 02:09:28 INFO - Cleaning up... 02:09:28 INFO - Return code: 0 02:09:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:29 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:29 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 02:09:29 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 02:09:29 INFO - Using env: {'DISPLAY': ':0', 02:09:29 INFO - 'HOME': '/home/cltbld', 02:09:29 INFO - 'LANG': 'en_US.UTF-8', 02:09:29 INFO - 'LANGUAGE': 'en_US:en', 02:09:29 INFO - 'LOGNAME': 'cltbld', 02:09:29 INFO - 'MAIL': '/var/mail/cltbld', 02:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:29 INFO - 'MOZ_NO_REMOTE': '1', 02:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:29 INFO - 'NO_EM_RESTART': '1', 02:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:29 INFO - 'PWD': '/builds/slave/test', 02:09:29 INFO - 'SHELL': '/bin/bash', 02:09:29 INFO - 'SHLVL': '1', 02:09:29 INFO - 'TERM': 'linux', 02:09:29 INFO - 'TMOUT': '86400', 02:09:29 INFO - 'USER': 'cltbld', 02:09:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:29 INFO - '_': '/tools/buildbot/bin/python'} 02:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:33 INFO - warning: no files found matching '*.txt' 02:09:33 INFO - no previously-included directories found matching 'build' 02:09:33 INFO - no previously-included directories found matching 'dist' 02:09:33 INFO - no previously-included directories found matching '.git*' 02:09:33 INFO - Installing collected packages: jsonschema, functools32 02:09:33 INFO - Running setup.py install for functools32 02:09:33 INFO - warning: no files found matching '*.txt' 02:09:33 INFO - no previously-included directories found matching 'build' 02:09:33 INFO - no previously-included directories found matching 'dist' 02:09:33 INFO - no previously-included directories found matching '.git*' 02:09:33 INFO - Successfully installed jsonschema functools32 02:09:33 INFO - Cleaning up... 02:09:33 INFO - Return code: 0 02:09:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:09:33 INFO - Using env: {'DISPLAY': ':0', 02:09:33 INFO - 'HOME': '/home/cltbld', 02:09:33 INFO - 'LANG': 'en_US.UTF-8', 02:09:33 INFO - 'LANGUAGE': 'en_US:en', 02:09:33 INFO - 'LOGNAME': 'cltbld', 02:09:33 INFO - 'MAIL': '/var/mail/cltbld', 02:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:33 INFO - 'MOZ_NO_REMOTE': '1', 02:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:33 INFO - 'NO_EM_RESTART': '1', 02:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:33 INFO - 'PWD': '/builds/slave/test', 02:09:33 INFO - 'SHELL': '/bin/bash', 02:09:33 INFO - 'SHLVL': '1', 02:09:33 INFO - 'TERM': 'linux', 02:09:33 INFO - 'TMOUT': '86400', 02:09:33 INFO - 'USER': 'cltbld', 02:09:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:33 INFO - '_': '/tools/buildbot/bin/python'} 02:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:09:33 INFO - Cleaning up... 02:09:33 INFO - Return code: 0 02:09:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:34 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:34 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 02:09:34 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 02:09:34 INFO - Using env: {'DISPLAY': ':0', 02:09:34 INFO - 'HOME': '/home/cltbld', 02:09:34 INFO - 'LANG': 'en_US.UTF-8', 02:09:34 INFO - 'LANGUAGE': 'en_US:en', 02:09:34 INFO - 'LOGNAME': 'cltbld', 02:09:34 INFO - 'MAIL': '/var/mail/cltbld', 02:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:34 INFO - 'MOZ_NO_REMOTE': '1', 02:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:34 INFO - 'NO_EM_RESTART': '1', 02:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:34 INFO - 'PWD': '/builds/slave/test', 02:09:34 INFO - 'SHELL': '/bin/bash', 02:09:34 INFO - 'SHLVL': '1', 02:09:34 INFO - 'TERM': 'linux', 02:09:34 INFO - 'TMOUT': '86400', 02:09:34 INFO - 'USER': 'cltbld', 02:09:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:34 INFO - '_': '/tools/buildbot/bin/python'} 02:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 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 02:09:37 INFO - Downloading docopt-0.6.1.tar.gz 02:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:37 INFO - Running setup.py install for blobuploader 02:09:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:37 INFO - Running setup.py install for requests 02:09:38 INFO - Running setup.py install for docopt 02:09:38 INFO - Successfully installed blobuploader requests docopt 02:09:38 INFO - Cleaning up... 02:09:38 INFO - Return code: 0 02:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:38 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:38 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 02:09:38 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 02:09:38 INFO - Using env: {'DISPLAY': ':0', 02:09:38 INFO - 'HOME': '/home/cltbld', 02:09:38 INFO - 'LANG': 'en_US.UTF-8', 02:09:38 INFO - 'LANGUAGE': 'en_US:en', 02:09:38 INFO - 'LOGNAME': 'cltbld', 02:09:38 INFO - 'MAIL': '/var/mail/cltbld', 02:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:38 INFO - 'MOZ_NO_REMOTE': '1', 02:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:38 INFO - 'NO_EM_RESTART': '1', 02:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:38 INFO - 'PWD': '/builds/slave/test', 02:09:38 INFO - 'SHELL': '/bin/bash', 02:09:38 INFO - 'SHLVL': '1', 02:09:38 INFO - 'TERM': 'linux', 02:09:38 INFO - 'TMOUT': '86400', 02:09:38 INFO - 'USER': 'cltbld', 02:09:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:38 INFO - '_': '/tools/buildbot/bin/python'} 02:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:38 INFO - Running setup.py (path:/tmp/pip-Sd_gVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:39 INFO - Running setup.py (path:/tmp/pip-n1jX2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:39 INFO - Running setup.py (path:/tmp/pip-IyT9DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:39 INFO - Running setup.py (path:/tmp/pip-j6L2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:39 INFO - Running setup.py (path:/tmp/pip-LAZkA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:39 INFO - Running setup.py (path:/tmp/pip-dyFpUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:39 INFO - Running setup.py (path:/tmp/pip-KN8Xae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:39 INFO - Running setup.py (path:/tmp/pip-ZbXyb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:39 INFO - Running setup.py (path:/tmp/pip-M_dvTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:39 INFO - Running setup.py (path:/tmp/pip-0Q9kx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:39 INFO - Running setup.py (path:/tmp/pip-HHF2m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:39 INFO - Running setup.py (path:/tmp/pip-J3vCJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:39 INFO - Running setup.py (path:/tmp/pip-hcO3Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:39 INFO - Running setup.py (path:/tmp/pip-KDJwXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:39 INFO - Running setup.py (path:/tmp/pip-bAaedm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:40 INFO - Running setup.py (path:/tmp/pip-3FYw9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:40 INFO - Running setup.py (path:/tmp/pip-ISi2RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:40 INFO - Running setup.py install for manifestparser 02:09:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:40 INFO - Running setup.py install for mozcrash 02:09:40 INFO - Running setup.py install for mozdebug 02:09:40 INFO - Running setup.py install for mozdevice 02:09:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:40 INFO - Running setup.py install for mozfile 02:09:40 INFO - Running setup.py install for mozhttpd 02:09:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:40 INFO - Running setup.py install for mozinfo 02:09:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:40 INFO - Running setup.py install for mozInstall 02:09:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Running setup.py install for mozleak 02:09:41 INFO - Running setup.py install for mozlog 02:09:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Running setup.py install for moznetwork 02:09:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Running setup.py install for mozprocess 02:09:41 INFO - Running setup.py install for mozprofile 02:09:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Running setup.py install for mozrunner 02:09:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:41 INFO - Running setup.py install for mozscreenshot 02:09:41 INFO - Running setup.py install for moztest 02:09:41 INFO - Running setup.py install for mozversion 02:09:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:42 INFO - Cleaning up... 02:09:42 INFO - Return code: 0 02:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:42 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')]} 02:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:42 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')]} 02:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:42 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:42 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 02:09:42 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 02:09:42 INFO - Using env: {'DISPLAY': ':0', 02:09:42 INFO - 'HOME': '/home/cltbld', 02:09:42 INFO - 'LANG': 'en_US.UTF-8', 02:09:42 INFO - 'LANGUAGE': 'en_US:en', 02:09:42 INFO - 'LOGNAME': 'cltbld', 02:09:42 INFO - 'MAIL': '/var/mail/cltbld', 02:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:42 INFO - 'MOZ_NO_REMOTE': '1', 02:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:42 INFO - 'NO_EM_RESTART': '1', 02:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:42 INFO - 'PWD': '/builds/slave/test', 02:09:42 INFO - 'SHELL': '/bin/bash', 02:09:42 INFO - 'SHLVL': '1', 02:09:42 INFO - 'TERM': 'linux', 02:09:42 INFO - 'TMOUT': '86400', 02:09:42 INFO - 'USER': 'cltbld', 02:09:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:42 INFO - '_': '/tools/buildbot/bin/python'} 02:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:42 INFO - Running setup.py (path:/tmp/pip-pmf3sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:42 INFO - Running setup.py (path:/tmp/pip-VMF1d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:42 INFO - Running setup.py (path:/tmp/pip-envrXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:42 INFO - Running setup.py (path:/tmp/pip-pUJ2gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:42 INFO - Running setup.py (path:/tmp/pip-cr5PVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:42 INFO - Running setup.py (path:/tmp/pip-vcxXbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:42 INFO - Running setup.py (path:/tmp/pip-EuBuAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:42 INFO - Running setup.py (path:/tmp/pip-vOiF9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:42 INFO - Running setup.py (path:/tmp/pip-eefMxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:42 INFO - Running setup.py (path:/tmp/pip-oCSy3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:42 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)) 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:42 INFO - Running setup.py (path:/tmp/pip-kQU_Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:43 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:43 INFO - Running setup.py (path:/tmp/pip-b5Ratc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:43 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:43 INFO - Running setup.py (path:/tmp/pip-3L8dGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:43 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:43 INFO - Running setup.py (path:/tmp/pip-Bd0pJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:43 INFO - Running setup.py (path:/tmp/pip-IrCRFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:43 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:43 INFO - Running setup.py (path:/tmp/pip-G0TCni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:43 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)) 02:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:43 INFO - Running setup.py (path:/tmp/pip-MRPTYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:43 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)) 02:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:09:43 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)) 02:09:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:09:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:09:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:43 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 02:09:43 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 02:09:43 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 02:09:43 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 02:09:43 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 02:09:43 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 02:09:48 INFO - Downloading blessings-1.6.tar.gz 02:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:48 INFO - Installing collected packages: blessings 02:09:48 INFO - Running setup.py install for blessings 02:09:48 INFO - Successfully installed blessings 02:09:48 INFO - Cleaning up... 02:09:49 INFO - Return code: 0 02:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:49 INFO - Reading from file tmpfile_stdout 02:09:49 INFO - Current package versions: 02:09:49 INFO - argparse == 1.2.1 02:09:49 INFO - blessings == 1.6 02:09:49 INFO - blobuploader == 1.2.4 02:09:49 INFO - docopt == 0.6.1 02:09:49 INFO - functools32 == 3.2.3-2 02:09:49 INFO - jsonschema == 2.5.1 02:09:49 INFO - manifestparser == 1.1 02:09:49 INFO - mozInstall == 1.12 02:09:49 INFO - mozcrash == 1.0 02:09:49 INFO - mozdebug == 0.1 02:09:49 INFO - mozdevice == 0.49 02:09:49 INFO - mozfile == 1.2 02:09:49 INFO - mozhttpd == 0.7 02:09:49 INFO - mozinfo == 0.9 02:09:49 INFO - mozleak == 0.1 02:09:49 INFO - mozlog == 3.4 02:09:49 INFO - moznetwork == 0.27 02:09:49 INFO - mozprocess == 0.23 02:09:49 INFO - mozprofile == 0.28 02:09:49 INFO - mozrunner == 6.13 02:09:49 INFO - mozscreenshot == 0.1 02:09:49 INFO - mozsystemmonitor == 0.3 02:09:49 INFO - moztest == 0.7 02:09:49 INFO - mozversion == 1.4 02:09:49 INFO - psutil == 3.1.1 02:09:49 INFO - requests == 1.2.3 02:09:49 INFO - wsgiref == 0.1.2 02:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:49 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')]} 02:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:49 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')]} 02:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 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 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09:50 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 02:09:50 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 02:09:50 INFO - Using env: {'DISPLAY': ':0', 02:09:50 INFO - 'HOME': '/home/cltbld', 02:09:50 INFO - 'LANG': 'en_US.UTF-8', 02:09:50 INFO - 'LANGUAGE': 'en_US:en', 02:09:50 INFO - 'LOGNAME': 'cltbld', 02:09:50 INFO - 'MAIL': '/var/mail/cltbld', 02:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:50 INFO - 'MOZ_NO_REMOTE': '1', 02:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:50 INFO - 'NO_EM_RESTART': '1', 02:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:50 INFO - 'PWD': '/builds/slave/test', 02:09:50 INFO - 'SHELL': '/bin/bash', 02:09:50 INFO - 'SHLVL': '1', 02:09:50 INFO - 'TERM': 'linux', 02:09:50 INFO - 'TMOUT': '86400', 02:09:50 INFO - 'USER': 'cltbld', 02:09:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:50 INFO - '_': '/tools/buildbot/bin/python'} 02:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 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)) 02:09:50 INFO - Cleaning up... 02:09:50 INFO - Return code: 0 02:09:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09: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')]} 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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')]} 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f246c25de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cc120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, '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': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', '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 02:09: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', 'jsonschema'] in /builds/slave/test/build 02:09: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 jsonschema 02:09:50 INFO - Using env: {'DISPLAY': ':0', 02:09:50 INFO - 'HOME': '/home/cltbld', 02:09:50 INFO - 'LANG': 'en_US.UTF-8', 02:09:50 INFO - 'LANGUAGE': 'en_US:en', 02:09:50 INFO - 'LOGNAME': 'cltbld', 02:09:50 INFO - 'MAIL': '/var/mail/cltbld', 02:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:50 INFO - 'MOZ_NO_REMOTE': '1', 02:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:50 INFO - 'NO_EM_RESTART': '1', 02:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:50 INFO - 'PWD': '/builds/slave/test', 02:09:50 INFO - 'SHELL': '/bin/bash', 02:09:50 INFO - 'SHLVL': '1', 02:09:50 INFO - 'TERM': 'linux', 02:09:50 INFO - 'TMOUT': '86400', 02:09:50 INFO - 'USER': 'cltbld', 02:09:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:50 INFO - '_': '/tools/buildbot/bin/python'} 02:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:09:50 INFO - Cleaning up... 02:09:50 INFO - Return code: 0 02:09:50 INFO - Running post-action listener: _resource_record_post_action 02:09:50 INFO - Running post-action listener: _start_resource_monitoring 02:09:50 INFO - Starting resource monitoring. 02:09:50 INFO - [mozharness: 2016-12-08 10:09:50.744906Z] Finished create-virtualenv step (success) 02:09:50 INFO - [mozharness: 2016-12-08 10:09:50.745433Z] Running install step. 02:09:50 INFO - Running pre-action listener: _resource_record_pre_action 02:09:50 INFO - Running main action method: install 02:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:50 INFO - Reading from file tmpfile_stdout 02:09:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:51 INFO - Reading from file tmpfile_stdout 02:09:51 INFO - Output received: 02:09:51 INFO - Usage: mozinstall [options] installer 02:09:51 INFO - Options: 02:09:51 INFO - -h, --help show this help message and exit 02:09:51 INFO - -d DEST, --destination=DEST 02:09:51 INFO - Directory to install application into. [default: 02:09:51 INFO - "/builds/slave/test"] 02:09:51 INFO - --app=APP Application being installed. [default: firefox] 02:09:51 INFO - mkdir: /builds/slave/test/build/application 02:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:10:08 INFO - Reading from file tmpfile_stdout 02:10:08 INFO - Output received: 02:10:08 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:08 INFO - Running post-action listener: _resource_record_post_action 02:10:08 INFO - [mozharness: 2016-12-08 10:10:08.026939Z] Finished install step (success) 02:10:08 INFO - [mozharness: 2016-12-08 10:10:08.027217Z] Running run-tests step. 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: run_tests 02:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:08 INFO - Python 2.7.3 02:10:08 INFO - Return code: 0 02:10:08 INFO - grabbing minidump binary from tooltool 02:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:08 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 0x295cf20>, '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 0x28c9c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:08 INFO - Return code: 0 02:10:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:10:08 INFO - Using env: {'DISPLAY': ':0', 02:10:08 INFO - 'HOME': '/home/cltbld', 02:10:08 INFO - 'LANG': 'en_US.UTF-8', 02:10:08 INFO - 'LANGUAGE': 'en_US:en', 02:10:08 INFO - 'LOGNAME': 'cltbld', 02:10:08 INFO - 'MAIL': '/var/mail/cltbld', 02:10:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:08 INFO - 'MOZ_NO_REMOTE': '1', 02:10:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:08 INFO - 'NO_EM_RESTART': '1', 02:10:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:08 INFO - 'PWD': '/builds/slave/test', 02:10:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:08 INFO - 'SHELL': '/bin/bash', 02:10:08 INFO - 'SHLVL': '1', 02:10:08 INFO - 'TERM': 'linux', 02:10:08 INFO - 'TMOUT': '86400', 02:10:08 INFO - 'USER': 'cltbld', 02:10:08 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277', 02:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:08 INFO - '_': '/tools/buildbot/bin/python'} 02:10:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:10:08 INFO - mozversion application_buildid: 20161208003003 02:10:08 INFO - mozversion application_changeset: 82aeade4d0073cd0c2da2d61543fe0a50430cfbb 02:10:08 INFO - mozversion application_display_name: Nightly 02:10:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:08 INFO - mozversion application_name: Firefox 02:10:08 INFO - mozversion application_remotingname: firefox 02:10:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:10:08 INFO - mozversion application_vendor: Mozilla 02:10:08 INFO - mozversion application_version: 53.0a1 02:10:08 INFO - mozversion platform_buildid: 20161208003003 02:10:08 INFO - mozversion platform_changeset: 82aeade4d0073cd0c2da2d61543fe0a50430cfbb 02:10:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:10:08 INFO - mozversion platform_version: 53.0a1 02:10:08 INFO - using testdate: 1481191808 02:10:08 INFO - actual date: 1481191808 02:10:08 INFO - starting webserver on 'localhost:49237' 02:10:08 INFO - SUITE-START | Running 2 tests 02:10:08 INFO - TEST-START | dromaeo_css 02:10:08 INFO - operating with platform_type : linux_ 02:10:08 INFO - Initialising browser for dromaeo_css test... 02:10:08 INFO - TEST-INFO | started process 27142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXpAApU/profile http://localhost:49237/getInfo.html) 02:10:12 INFO - PROCESS | 27142 | __metrics Screen width/height:1600/1200 02:10:12 INFO - PROCESS | 27142 | colorDepth:24 02:10:12 INFO - PROCESS | 27142 | Browser inner width/height: 1024/697 02:10:12 INFO - PROCESS | 27142 | __metrics 02:10:13 ERROR - PROCESS | 27142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 02:10:14 INFO - TEST-INFO | 27142: exit 0 02:10:14 INFO - Browser initialized. 02:10:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:14 INFO - TEST-INFO | started process 27264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXpAApU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:26 INFO - PROCESS | 27264 | RSS: Main: 184733696 02:10:26 INFO - PROCESS | 27264 | 02:11:15 INFO - PROCESS | 27264 | 1481191875918 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] 02:13:27 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 02:13:28 INFO - PROCESS | 27264 | RSS: Main: 197832704 02:13:28 INFO - PROCESS | 27264 | 02:16:31 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 02:16:31 INFO - PROCESS | 27264 | RSS: Main: 197304320 02:16:31 INFO - PROCESS | 27264 | 02:19:33 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 02:19:34 INFO - PROCESS | 27264 | RSS: Main: 199290880 02:19:34 INFO - PROCESS | 27264 | 02:22:36 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 02:22:37 INFO - PROCESS | 27264 | RSS: Main: 195465216 02:22:37 INFO - PROCESS | 27264 | 02:25:39 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 02:25:40 INFO - PROCESS | 27264 | RSS: Main: 199290880 02:25:40 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 02:28:43 INFO - PROCESS | 27264 | RSS: Main: 199081984 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | __start_tp_report 02:28:43 INFO - PROCESS | 27264 | _x_x_mozilla_page_load 02:28:43 INFO - PROCESS | 27264 | _x_x_mozilla_page_load_details 02:28:43 INFO - PROCESS | 27264 | |i|pagename|runs| 02:28:43 INFO - PROCESS | 27264 | |0;dojo.html;3330.833458327084;3343.6322004579506;3362.4451965425696;3368.427367347551;3387.864485420583;5323.866903327419;5356.437574054722;5403.648762830413;5406.16204488304;5446.891062178754;5336.199570064492;5367.597430192732;5373.220882971967;5398.649087809299;5486.890262194754;4868.221084626461;4917.72952487613;4943.134951383511;5032.6477146599755;5056.797728090872;4956.925646115311;5088.440271570124;5099.184130539114;5113.667611605252;5123.436421993578;4749.4775574686755;4996.325496058058;5023.6985780853265;5031.144705400091;5046.747662616873;4826.131296366652;4872.220444728827;4881.389826271716;4908.410990681141;4933.7286449245275;4941.45643979162;4965.503449655042;4975.378077740283;4999.775010124553;5015.548600625924;5378.300820893259;5385.35375754908;5419.864503387407;5445.128779395317;5465.9180112298345;5698.34469036062;5751.022326204556;5793.681347525884;5818.272715910512;5841.649501029951;5707.4577915098;5766.163906233573;5775.3935836736955;5804.738786754606;5859.121131830259;5369.114096174127;5405.891882162335;5407.594430417695;5409.486098820606;5412.107002344569;5679.062954612526;5864.266966629171;5875.148103524965;5884.146798714162;5886.234789477427;5592.664440133605;5624.775008999594;5667.773289068474;5686.914696279477;5701.942980570224;5773.422657734193;5784.652920824764;5785.450382213683;5785.942140578624;5791;5614.859628509238;5639.830805075854;5647.830565083054;5657.094864821609;5691.430856914359;5511.559075274049;5651.124075768263;5712.742926568314;5736.741846616829;5769.48074673273;4395.780210989502;4427.756473393994;4437.600615944581;4453.376527286183;4507.414036175342;3977.2840888639744;3996.300647386754;4003.199360127986;4038.596140385938;4072.429859819628;5388.164834450588;5479.726013699299;5483.533899618577;5484.341878974548;5519.172124181405;5669.914951275734;5685.744141513642;5720.914186287209;5722.799702010493;5793.710314484259;5419.783208671609;5455.345358556999;5457.126859702428;5476.507114359647;5480.479354461319;4918.213085906309;4943.233798761198;4952.921449761386;4954.529319714621;4993.226049962262;5799.971000144972;5845.210896528914;5852.473277405054;5930.199423078002;5941.257342832146;5671.376148623731;5711.257536520226;5731.627444216113;5734.54123670097;5751.194832723506;5980.581359304981;6047.727852246748;6052.515798736003;6101.450869421773;6111.84720381994;5679.858003549944;5736.196932429547;5746.712664366682;5753.252077229933;5754.482096611325;5736.971315143398;5765.538756899522;5821.563382746226;5829.621074630136;5841.853953651193;5566.944330556805;5623.465770751772;5652.3217213934595;5658.264425624642;5675.432456754292;5524.558035357242;5526.751296191762;5578.30271216098;5637.098064309691;5711.628744131618;5476.91784623223;5525.696086715269;5550.500454958911;5580.190872323572;5602.159676048463;5658.321001479849;5665.348484924121;5667.036603777286;5685.971570142123;5700.144978253295;5396.3524377075;5427.592930530147;5432.592555558428;5446.918296225481;5524.088525393265 02:28:43 INFO - PROCESS | 27264 | |1;ext.html;557.8772670012597;563.3605857351907;576.4235764235763;577.1371799160256;589.8967680655884;40840.59159408405;42607.36088958664;42661.57338426615;45407;45457.31814022792;42450.7877460613;43054.7847260764;43073;43084.56915430845;43125.7843710781;8539.188777066185;8641.308695304391;10093.293469457141;10340.37957722539;10355.534000969974;10115.494225288743;10193.133583645398;10231.795364092713;10232.846507302396;10239.641612543563;10291.63979260726;10322.690319290434;10332.58669653213;10370.118539924115;10374.170066394709;10243.23175761817;10245.28283020189;10281.53733082013;10300;10323.741906452324;10257.89742102577;10293.176545876311;10325.63860264887;10343.431111288875;10351.275410721253;39917.60082399168;40421.595784042074;40452;40497.190056199004;40526.59473405287;3612.3858943979326;4001.679865610744;4046.251443482965;4059.106996460774;4120.001799127421;31081.37837243265;31126.844365778026;31222;31781.6821831781;31841.681583184105;4005;4154.979225103885;4248.490181178278;4401.889952751207;4404.075144219718;330170;330204;332370.99999999756;332373;333000;59420.40579594235;59483.40516594865;59685;59728.402715973156;59827.40172598305;62899.37100629027;62959.370406296264;62963.6851815738;63154;63171.36828631747;14033.087849289763;15327.770083448757;15515.534533963773;15544.378224870878;15577.766333505006;10634.840477392845;11357.716057098638;11541.76916461666;11583.594574189863;11893.940530297466;18491.630167396575;18589.163487643087;18743.812561874478;18793.812061879205;18905.24379024851;6560.606363618198;6804.4216241620015;6917.342852429011;7028.543144695578;7144.785656430211;881.38743573216;955.5174636808367;1024.8360262357987;1056.822870322961;1084.0568705226503;30701.692983069883;31332.530012049836;31354;31415.37169256602;31850.840745796122;1093.6718984304678;1097.401915955806;1119.5689659481159;1125.3472985668293;1176.5529098942347;16007.839921600867;16757;16833;16851.325946962228;16865.241064152142;444872;449561;450270;451246;453479;56566.7171664139;57281.713591432606;57330;57429.42570574324;57455.138172927436;1239.0459346303296;1304.8434187897512;1308.339288659221;1310.9475620975054;1322.0283091927427;29507.409851803273;30757.538636920017;30911.690883091782;31065.8446707765;31539.684603154594;50091.74954125206;50537.74731126321;50556.24165637592;50647;50750.23874641957;406489;407451;407933;408373;408730;26652.46695066049;28088.719112809427;28465.857670711513;28466.28834279077;28596.857015714788;43652.781736091114;43984.34023489714;44444.33333500065;44596;44673.776631116634;36955.63044369522;37232.81383593065;38157.2368552633;38367.6163238364;38710;38053.764675918894;38331.425028624035;38446;38696.613033869304;39870.202595948496;38685.80657096697;38870;39912.80043599763;41506.37740433835;43455.13089738124;33950.830245848614;36398.81800591086;36749.44875826811;37063.07342316356;37104.443433349064;26793.732062679122;27154.72845271601;27500.17499475019;29508.262293441978;29598.112056638336 02:28:43 INFO - PROCESS | 27264 | |2;jquery.html;383.88291571070846;388.9047183440054;404.2702921227185;405.0925925925926;419.8908283846201;17774.289028438863;18907.905460472713;19233.134508947096;19233.134508947096;19674.11466484008;18503.35238266661;18543.721844172316;18785.24859005638;18844.528886777836;18853.434396968078;5297.735113244332;5548;5683.403242659523;5730.484256416921;5759.769609215627;5604.299462567179;5659.320881494226;5662.17898404731;5685.800996965107;5704.54363650909;5437.700926449043;5561.694106824123;5592.6085174037835;5622.971885140569;5646.040173170551;5511.421300763423;5580.051391263495;5597.916031259514;5618.325800903917;5652.915206271889;4896.853094407174;5040.243963405518;5083.567896728782;5084.44924298089;5091.974540127313;22216.555668886693;22299.108035678553;22322;22572.548549029092;22638;2054.866433681821;2195.538936823269;2509.372656835791;2562.4490734492174;2980.716831900966;10110.342827716175;10183.828859681158;10604.310719803188;12210.267383956902;13688.110272832333;1870.812918708132;1926.6532024235632;1927.108890574119;1995.6208320419073;2051.979480205194;77659;78022.21977780206;79219.60390198127;80066.5996670013;80067;10735.463226838783;10927.235093543375;10984.176186786022;11129.549839549765;11129.721756956142;14638.268086595628;15152.090874547563;15153.924230378998;15182.544523664308;15185.468508602145;7571.129320128146;7581.696732130763;7620;7665.195154508808;7801.439712057498;7035.613041282779;7061.823454413578;7123.857522849514;7253.891191632129;7283.963580182065;4598.701084429501;4638.930416043762;4695.5539223773685;4723.220668589713;4745.098431298043;1927.7012063130237;1942.1066309497508;1984.900754962246;2002.6168859057675;2009.6784514477613;882.2544949517647;882.3514716683233;984.2027957354422;1010;1038.813013657549;17685.381011664787;19143;19352.516187095436;19461.708074378897;19477.220911163677;959.5777857742571;962.1821451765943;979.8187335342984;1013.0376142664499;1030.0111892583204;10283.588656453807;10760.838587421194;10812.135029197645;10860.348379097279;10891;400697;408752;408879;409814;412621;81621.59189204135;84269.57865210634;86108.56945715232;86371;86872;731.5500966905315;744.5346658338539;759.7644730133676;919.3977944446399;921.1663444582664;16481.587960301087;16592.83407165913;17022.319107236068;17425.47723568295;17500.82499174992;40711.79644101761;40939.38590921198;41507.16985660209;41769.58230417657;42723;52572.9485410282;54626;55284;55665.44334556765;57224.71387643035;8266.669333226604;8275.95862020686;8419.663213471393;8572.099929507312;8617.913820861711;9428.15146636806;12056.51773929068;12525.686857828627;12756;12899.613011609667;10478.266521343432;10802.459877006275;10825.296355736851;10865.782684346426;11507.597234096766;11290.943545282222;11325.263857849213;11491.48288327044;11707.180497365443;11841.881581184078;11413;11500.48247828833;11745;11888;12189.939050304693;8301.750947471586;8419.115992820665;8468.44955077918;8656.567171641518;8772.29821614282;9506.382085164441;11602.593909213474;11875.168738188244;11921.463534141158;12172.634820955385 02:28:43 INFO - PROCESS | 27264 | |3;mootools.html;1384.709211065676;1421.9644508887277;1460.4669295707063;1586.4050980882168;1610.0822531157246;7816.921830781691;8068.757937261877;8271.875921861169;8302.045264794551;8322.83354332913;8240.7939801505;8384.664613415456;8388.83222335553;8389;8413.579321033954;2265.4676151104436;2311.9884400577976;2327.2552783109327;2332.4635333873134;2334.8248881333884;2321.94195145121;2348.283773449097;2365.60967440373;2377.132346693462;2387.3076807725824;2293.7706229377095;2299.540091981602;2319.512902290521;2321.5472982768365;2327.674125622406;2269.2994641794103;2273.056681477185;2297.655351697242;2298.0118549023914;2302.7236731592234;2238.160689741347;2268.0247493577754;2290.358699564125;2291.0950174681075;2291.942701432461;8258.380621453354;8274.503529788231;8374.371922105805;8396.244338009546;8401.831963360699;4873.780679869379;4913.361263035818;4954.702717836942;4969.850904472872;5017.799288028475;3062.38752249551;3064.417760625474;3287.2932319551173;3291.901242962715;3292.42382583047;1026.5226669598599;1045.3518818332682;1075.7256899490658;1088.4122573810212;1092.918031147667;11069.114470842394;11073.944630276797;11075.778484430266;11153.498092585773;11181.385023823768;4147.771872547039;4258.1057977824385;4323;4332;4446;9040.683576074805;9043.68347107848;9051.547422628842;9059.864102038475;9069.31980101495;4942.678725882806;4973.5523802857915;4976.701397916137;4976.90046199074;4980.153373926441;4501.977490112528;4538.092381523708;4666.253399456139;4705.694129881546;4744.501827308152;3591.9102022449124;3707.4068149096015;3715.461258117558;3759.7180211484247;3767.6232376762105;1136.6362763915633;1139.6865861888048;1148.0757989818276;1148.4372657397814;1172.302480024384;797.8045378882211;945.7257395355407;951.9333646644807;960.6925783749133;982.7641366072091;5374.731263436813;5496.038193316233;5565.191312823267;5655.800981149056;5770.480656740913;445.7414699474297;447.4630443467852;449.6200710399707;460.39688008708697;461.47852926193184;3797.6202379762353;3854.3257915399845;3904.707146963989;3909.58949310324;3910.9217815644097;9520.000399958044;9780.41317520951;9875.703728888146;9878.851817222603;9977.750556236153;9734.902650973541;9764.218862490983;9799.804003919882;9822.066903644143;9845.901540984498;7486.5508069516;7556.924430755732;7621.466497345133;7641.235876412315;7650.196729343339;5405.324334458192;5439.48324909133;5439.619226654097;5536.640118392292;5599.1041433370465;8884.600192991202;8887.73336799897;8909.955450222707;9013.18881300686;9063.456192628464;9085.409448385833;9232.03063678331;9239.491827949527;9255.167034966886;9483.857742134012;6669.899951500634;6860.48546359035;7055.6472176392;7372.373348265458;7536.773896783106;7822.726204582812;8153.470024448392;8166.918330816616;8169.714060007871;8187.345012399113;7187.604681742554;7262.9273707262255;7438.62806859644;7442.032535770315;7457.664405101675;6972.51192416526;7088;7117.501774875709;7245.094363204599;7318.268173182639;6517.315681853337;6550.148480697479;6561.245456772533;6564.606123632598;6608.966955165193;4705.34125222476;4822.903541929071;4847.80608775645;4864.635152363516;4890.510948905223;4835.323054772264;4895.6817806843865;4928.359313289393;5002.599792016703;5059.747012649426 02:28:43 INFO - PROCESS | 27264 | |4;prototype.html;330.87922908138523;336.7709957229083;340.50966608084343;341.1114047905207;351.7942003927702;5444.482774136461;5485.314335708036;5522.972385138079;5538.556915446765;5562.471565201309;5377.247185394038;5396.91904621431;5413.783448662059;5442.074847275962;5481.698506582136;4247.06564555798;4295.226859165349;4312.2453570625175;4322.832835134512;4325.718828276152;4076.408920706496;4219.092895027568;4283.7215580987295;4305.3541968704785;4340.65274778017;4210.642095421893;4222.809973551182;4232.640225580829;4232.746035237896;4245.118114168716;4205;4216.346466297744;4216.810243539048;4228.76741779202;4233.23801715691;3735.5431381761136;3741.6258374162367;3753.981230093832;3754.8498060077563;3760.793156376398;5122.847359344155;5279.63042587019;5303.700593354614;5307.929907336142;5331.413544510101;4822.927656085161;4837.467878533358;4849.321095046696;4859.41686997559;4872.756362181912;5432.483914028161;5578.330600327987;5681.261436013333;5682.54539636828;5713.371529131834;4071.2671719090554;4093.421144678863;4096.160287141129;4105.2405305018665;4127.422160897477;5933.525317974595;5950.97024514879;5971.4327138921735;5980.491658209057;5981.371955944606;3972.980135099364;4182.853600123981;4193.811278492475;4195.1819395217635;4214.64175545076;4165.229777344677;4202.222588821078;4220.746755194698;4228.6617070634275;4249.2988656871885;4858.562729354375;4875.07373599015;4893.140606569481;4895;4906.190478571068;5488.670679759148;5771.220885180447;5797.565182611321;5826.621269617462;5873.913326034697;1409.9647508812157;1423.395057100728;1425;1427.7715565509468;1431.8854491640643;921.3872774604813;948.672707915768;951.5622813505727;973.9773238099966;977.8875429325718;5369.7583608737705;5376.489233522809;5381.623286369917;5391.299131113009;5399.433059528771;5656.604037717402;5699.800506982236;5702.258706368146;5712.343080545707;5716.228309178291;5169.327987361694;5318.468153184651;5332.533553272881;5408.756605952742;5416.729163541807;2942.6174597302215;2954.7691492922704;2978.6298302780965;3017.9396412071637;3023.6220472440946;5837.503812175928;5854.502367298742;5903.852403689856;5913.645181289136;5957.970210148921;5636.4927156556105;5984.581079324493;5992.31088424828;6003.249593800775;6054.182685337511;6145.600535965148;6172.753089876354;6185.969070154621;6193.84515387119;6218.626882387071;5576.386597474356;5801.216835727123;5803.9419605803405;5820.243368362086;5838.503727183067;5795.478406943395;5828.271466066742;5861.296644402699;5871.119332100219;5874.647521148745;5871.94128058714;6093.512518998558;6197.690115494117;6206.751729930752;6226.968865155645;3954.1696243789124;4065.5809793173016;4094.6519545838937;4118.320477121241;4123.876283711494;5840;5864.44287792659;5874.970625147018;5878.178474332259;5878.617889837147;5572.916406253828;5730.71346432685;5734.340550836707;5736.483716465538;5752.597318187687;5643.858903527444;5675.120356344773;5676.574256930664;5684.436779885565;5711.714414279352;5647.1529270609735;5654.7455364509515;5667.3482549507335;5701.949457040463;5717.599768016199;5517.586181036358;5673.858153546194;5677.914831277617;5723.828285151452;5805.896879592864;5623.690697011703;5624.943750562442;5634.408387119293;5638.9436105638415;5652.915206271991 02:28:43 INFO - PROCESS | 27264 | |5;yui.html;721.46251042973;732.9413646908248;750.9336741826605;769.4075561817401;789.9131095579481;14600.269986500673;15355.692886142284;15442.459513917001;15446.84553154468;15480.845191548082;14166.433342666282;14293.070950388217;14307.928460357709;14317.427302907898;14318.92840535796;627;644.7485480662522;743;749.232037161908;758.2303961479104;753.130134694426;760.3536993555462;762.2073044034225;762.4929421934435;762.5691484311374;809.2069771623812;811.7077851973285;813.1461964936822;813.4387272781792;813.7640084375524;803.1807556292578;807.0718673525434;808.1191501263621;810.1776696652902;813.158381075584;592.5851903667407;593.4510577715639;593.7476572456688;594.111802854735;596.1802521532892;14930.25348732559;15003.1748253846;15034.624134396727;15053;15655.843441565552;15139.545813625498;15213.676921693464;15472.14903180336;15868;15869.920650396674;11323.320600763898;11861;12012.159148859584;12140;12597.874021259762;3484.163800687842;3495.755297129202;3587.121155316964;3616.5479315085613;3687.944680829763;80879.19120808835;81343;81600;82399.58800205961;83251.16748832495;11246.381449020382;11323;11451.141164412702;11527.596534121265;11561.479733412016;22383.32850014502;22438.551228975328;22699.432514187276;22964;23079.42301442444;7519.548827070394;7703.499272547267;7791.883121753178;8017.118117007125;8236.217559331853;4365.978170109129;4413.911721765547;4439.378487011821;4485.237509623372;4666.789994450258;3150.8109513429267;3205.0705295464054;3226.080567038383;3453.7755045921936;3616.3129005488872;627.1877918096077;630.3192552043873;633.6451587111233;641.868416974519;648.8053583924803;580.2659635561018;622.2501885228289;646.6880900779731;708.2775568919776;709.2800807180715;8515.829683406297;9050.86423703645;9069.274458043341;9112.225460835904;9331.953340233391;679.4564348521163;688.9655517224219;700.765243643375;707;715.5456285258898;4327.8485253016;4341.45731783527;4586.862394128181;4587.747673877902;4677.602403795716;85786.14213857906;85931;86616;86840;88043;56383.71808140933;61292;70683.6465817678;75422;77332.61333693408;68143.31856681469;68202.65898670474;68561.3143868565;69179.65410172917;69759.65120174366;8520.616572254388;8545.145485451405;8773.122687731431;8781.165789250012;8804.987600712859;45378.731063447354;45498;46916.06167876691;47280.52719472761;47474.38890860898;59591.702041489516;61006;64583.35416645961;65676;66043.33956660565;12668.936655317033;12698.619041428772;12990.35048247565;13105.27920964356;13752.587422377344;14421.855781442051;14619.903507236788;15131.621709457351;15262.23688815577;16090.275937582603;13297.601071967856;13491.257980810757;13685.589432317047;14370.640733981734;14493.492727754478;13361.26513041753;13964.650883727989;14324.068935519157;14431.927840360731;14981.550553483414;12533.686657833627;13108;14079.577612671636;14092.295385230493;14600.904932130345;11125.276857004268;11305.943470282926;11761.235519691192;11817.409129543661;12359.938200308941;9683.518615678426;10463.790724185626;12130.170177518286;12272.938635307124;12451.377431128589 02:28:43 INFO - PROCESS | 27264 | __end_tp_report 02:28:43 INFO - PROCESS | 27264 | __start_cc_report 02:28:43 INFO - PROCESS | 27264 | _x_x_mozilla_cycle_collect,316 02:28:43 INFO - PROCESS | 27264 | __end_cc_report 02:28:43 INFO - PROCESS | 27264 | __startTimestamp1481192923640__endTimestamp 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | ------- Summary: start ------- 02:28:43 INFO - PROCESS | 27264 | Number of tests: 6 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#0] dojo.html Cycles:165 Average:5368.02 Median:5524.56 stddev:561.15 (10.2%) stddev-sans-first:539.63 02:28:43 INFO - PROCESS | 27264 | Values: 3330.8 3343.6 3362.4 3368.4 3387.9 5323.9 5356.4 5403.6 5406.2 5446.9 5336.2 5367.6 5373.2 5398.6 5486.9 4868.2 4917.7 4943.1 5032.6 5056.8 4956.9 5088.4 5099.2 5113.7 5123.4 4749.5 4996.3 5023.7 5031.1 5046.7 4826.1 4872.2 4881.4 4908.4 4933.7 4941.5 4965.5 4975.4 4999.8 5015.5 5378.3 5385.4 5419.9 5445.1 5465.9 5698.3 5751.0 5793.7 5818.3 5841.6 5707.5 5766.2 5775.4 5804.7 5859.1 5369.1 5405.9 5407.6 5409.5 5412.1 5679.1 5864.3 5875.1 5884.1 5886.2 5592.7 5624.8 5667.8 5686.9 5701.9 5773.4 5784.7 5785.5 5785.9 5791.0 5614.9 5639.8 5647.8 5657.1 5691.4 5511.6 5651.1 5712.7 5736.7 5769.5 4395.8 4427.8 4437.6 4453.4 4507.4 3977.3 3996.3 4003.2 4038.6 4072.4 5388.2 5479.7 5483.5 5484.3 5519.2 5669.9 5685.7 5720.9 5722.8 5793.7 5419.8 5455.3 5457.1 5476.5 5480.5 4918.2 4943.2 4952.9 4954.5 4993.2 5800.0 5845.2 5852.5 5930.2 5941.3 5671.4 5711.3 5731.6 5734.5 5751.2 5980.6 6047.7 6052.5 6101.5 6111.8 5679.9 5736.2 5746.7 5753.3 5754.5 5737.0 5765.5 5821.6 5829.6 5841.9 5566.9 5623.5 5652.3 5658.3 5675.4 5524.6 5526.8 5578.3 5637.1 5711.6 5476.9 5525.7 5550.5 5580.2 5602.2 5658.3 5665.3 5667.0 5686.0 5700.1 5396.4 5427.6 5432.6 5446.9 5524.1 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#1] ext.html Cycles:180 Average:56262.14 Median:37009.35 stddev:105355.54 (284.7%) stddev-sans-first:105568.08 02:28:43 INFO - PROCESS | 27264 | Values: 557.9 563.4 576.4 577.1 589.9 40840.6 42607.4 42661.6 45407.0 45457.3 42450.8 43054.8 43073.0 43084.6 43125.8 8539.2 8641.3 10093.3 10340.4 10355.5 10115.5 10193.1 10231.8 10232.8 10239.6 10291.6 10322.7 10332.6 10370.1 10374.2 10243.2 10245.3 10281.5 10300.0 10323.7 10257.9 10293.2 10325.6 10343.4 10351.3 39917.6 40421.6 40452.0 40497.2 40526.6 3612.4 4001.7 4046.3 4059.1 4120.0 31081.4 31126.8 31222.0 31781.7 31841.7 4005.0 4155.0 4248.5 4401.9 4404.1 330170.0 330204.0 332371.0 332373.0 333000.0 59420.4 59483.4 59685.0 59728.4 59827.4 62899.4 62959.4 62963.7 63154.0 63171.4 14033.1 15327.8 15515.5 15544.4 15577.8 10634.8 11357.7 11541.8 11583.6 11893.9 18491.6 18589.2 18743.8 18793.8 18905.2 6560.6 6804.4 6917.3 7028.5 7144.8 881.4 955.5 1024.8 1056.8 1084.1 30701.7 31332.5 31354.0 31415.4 31850.8 1093.7 1097.4 1119.6 1125.3 1176.6 16007.8 16757.0 16833.0 16851.3 16865.2 444872.0 449561.0 450270.0 451246.0 453479.0 56566.7 57281.7 57330.0 57429.4 57455.1 1239.0 1304.8 1308.3 1310.9 1322.0 29507.4 30757.5 30911.7 31065.8 31539.7 50091.7 50537.7 50556.2 50647.0 50750.2 406489.0 407451.0 407933.0 408373.0 408730.0 26652.5 28088.7 28465.9 28466.3 28596.9 43652.8 43984.3 44444.3 44596.0 44673.8 36955.6 37232.8 38157.2 38367.6 38710.0 38053.8 38331.4 38446.0 38696.6 39870.2 38685.8 38870.0 39912.8 41506.4 43455.1 33950.8 36398.8 36749.4 37063.1 37104.4 26793.7 27154.7 27500.2 29508.3 29598.1 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#2] jquery.html Cycles:180 Average:26222.98 Median:404.68 stddev:67612.08 (16707.5%) stddev-sans-first:67773.91 02:28:43 INFO - PROCESS | 27264 | Values: 383.9 388.9 404.3 405.1 419.9 17774.3 18907.9 19233.1 19233.1 19674.1 18503.4 18543.7 18785.2 18844.5 18853.4 5297.7 5548.0 5683.4 5730.5 5759.8 5604.3 5659.3 5662.2 5685.8 5704.5 5437.7 5561.7 5592.6 5623.0 5646.0 5511.4 5580.1 5597.9 5618.3 5652.9 4896.9 5040.2 5083.6 5084.4 5092.0 22216.6 22299.1 22322.0 22572.5 22638.0 2054.9 2195.5 2509.4 2562.4 2980.7 10110.3 10183.8 10604.3 12210.3 13688.1 1870.8 1926.7 1927.1 1995.6 2052.0 77659.0 78022.2 79219.6 80066.6 80067.0 10735.5 10927.2 10984.2 11129.5 11129.7 14638.3 15152.1 15153.9 15182.5 15185.5 7571.1 7581.7 7620.0 7665.2 7801.4 7035.6 7061.8 7123.9 7253.9 7284.0 4598.7 4638.9 4695.6 4723.2 4745.1 1927.7 1942.1 1984.9 2002.6 2009.7 882.3 882.4 984.2 1010.0 1038.8 17685.4 19143.0 19352.5 19461.7 19477.2 959.6 962.2 979.8 1013.0 1030.0 10283.6 10760.8 10812.1 10860.3 10891.0 400697.0 408752.0 408879.0 409814.0 412621.0 81621.6 84269.6 86108.6 86371.0 86872.0 731.6 744.5 759.8 919.4 921.2 16481.6 16592.8 17022.3 17425.5 17500.8 40711.8 40939.4 41507.2 41769.6 42723.0 52572.9 54626.0 55284.0 55665.4 57224.7 8266.7 8276.0 8419.7 8572.1 8617.9 9428.2 12056.5 12525.7 12756.0 12899.6 10478.3 10802.5 10825.3 10865.8 11507.6 11290.9 11325.3 11491.5 11707.2 11841.9 11413.0 11500.5 11745.0 11888.0 12189.9 8301.8 8419.1 8468.4 8656.6 8772.3 9506.4 11602.6 11875.2 11921.5 12172.6 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#3] mootools.html Cycles:180 Average:5383.08 Median:4978.53 stddev:2979.83 (59.9%) stddev-sans-first:2973.03 02:28:43 INFO - PROCESS | 27264 | Values: 1384.7 1422.0 1460.5 1586.4 1610.1 7816.9 8068.8 8271.9 8302.0 8322.8 8240.8 8384.7 8388.8 8389.0 8413.6 2265.5 2312.0 2327.3 2332.5 2334.8 2321.9 2348.3 2365.6 2377.1 2387.3 2293.8 2299.5 2319.5 2321.5 2327.7 2269.3 2273.1 2297.7 2298.0 2302.7 2238.2 2268.0 2290.4 2291.1 2291.9 8258.4 8274.5 8374.4 8396.2 8401.8 4873.8 4913.4 4954.7 4969.9 5017.8 3062.4 3064.4 3287.3 3291.9 3292.4 1026.5 1045.4 1075.7 1088.4 1092.9 11069.1 11073.9 11075.8 11153.5 11181.4 4147.8 4258.1 4323.0 4332.0 4446.0 9040.7 9043.7 9051.5 9059.9 9069.3 4942.7 4973.6 4976.7 4976.9 4980.2 4502.0 4538.1 4666.3 4705.7 4744.5 3591.9 3707.4 3715.5 3759.7 3767.6 1136.6 1139.7 1148.1 1148.4 1172.3 797.8 945.7 951.9 960.7 982.8 5374.7 5496.0 5565.2 5655.8 5770.5 445.7 447.5 449.6 460.4 461.5 3797.6 3854.3 3904.7 3909.6 3910.9 9520.0 9780.4 9875.7 9878.9 9977.8 9734.9 9764.2 9799.8 9822.1 9845.9 7486.6 7556.9 7621.5 7641.2 7650.2 5405.3 5439.5 5439.6 5536.6 5599.1 8884.6 8887.7 8910.0 9013.2 9063.5 9085.4 9232.0 9239.5 9255.2 9483.9 6669.9 6860.5 7055.6 7372.4 7536.8 7822.7 8153.5 8166.9 8169.7 8187.3 7187.6 7262.9 7438.6 7442.0 7457.7 6972.5 7088.0 7117.5 7245.1 7318.3 6517.3 6550.1 6561.2 6564.6 6609.0 4705.3 4822.9 4847.8 4864.6 4890.5 4835.3 4895.7 4928.4 5002.6 5059.7 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#4] prototype.html Cycles:180 Average:4795.79 Median:5463.09 stddev:1420.54 (26.0%) stddev-sans-first:1384.43 02:28:43 INFO - PROCESS | 27264 | Values: 330.9 336.8 340.5 341.1 351.8 5444.5 5485.3 5523.0 5538.6 5562.5 5377.2 5396.9 5413.8 5442.1 5481.7 4247.1 4295.2 4312.2 4322.8 4325.7 4076.4 4219.1 4283.7 4305.4 4340.7 4210.6 4222.8 4232.6 4232.7 4245.1 4205.0 4216.3 4216.8 4228.8 4233.2 3735.5 3741.6 3754.0 3754.8 3760.8 5122.8 5279.6 5303.7 5307.9 5331.4 4822.9 4837.5 4849.3 4859.4 4872.8 5432.5 5578.3 5681.3 5682.5 5713.4 4071.3 4093.4 4096.2 4105.2 4127.4 5933.5 5951.0 5971.4 5980.5 5981.4 3973.0 4182.9 4193.8 4195.2 4214.6 4165.2 4202.2 4220.7 4228.7 4249.3 4858.6 4875.1 4893.1 4895.0 4906.2 5488.7 5771.2 5797.6 5826.6 5873.9 1410.0 1423.4 1425.0 1427.8 1431.9 921.4 948.7 951.6 974.0 977.9 5369.8 5376.5 5381.6 5391.3 5399.4 5656.6 5699.8 5702.3 5712.3 5716.2 5169.3 5318.5 5332.5 5408.8 5416.7 2942.6 2954.8 2978.6 3017.9 3023.6 5837.5 5854.5 5903.9 5913.6 5958.0 5636.5 5984.6 5992.3 6003.2 6054.2 6145.6 6172.8 6186.0 6193.8 6218.6 5576.4 5801.2 5803.9 5820.2 5838.5 5795.5 5828.3 5861.3 5871.1 5874.6 5871.9 6093.5 6197.7 6206.8 6227.0 3954.2 4065.6 4094.7 4118.3 4123.9 5840.0 5864.4 5875.0 5878.2 5878.6 5572.9 5730.7 5734.3 5736.5 5752.6 5643.9 5675.1 5676.6 5684.4 5711.7 5647.2 5654.7 5667.3 5701.9 5717.6 5517.6 5673.9 5677.9 5723.8 5805.9 5623.7 5624.9 5634.4 5638.9 5652.9 02:28:43 INFO - PROCESS | 27264 | 02:28:43 INFO - PROCESS | 27264 | [#5] yui.html Cycles:180 Average:18404.98 Median:25796.83 stddev:24157.08 (93.6%) stddev-sans-first:24188.36 02:28:43 INFO - PROCESS | 27264 | Values: 721.5 732.9 750.9 769.4 789.9 14600.3 15355.7 15442.5 15446.8 15480.8 14166.4 14293.1 14307.9 14317.4 14318.9 627.0 644.7 743.0 749.2 758.2 753.1 760.4 762.2 762.5 762.6 809.2 811.7 813.1 813.4 813.8 803.2 807.1 808.1 810.2 813.2 592.6 593.5 593.7 594.1 596.2 14930.3 15003.2 15034.6 15053.0 15655.8 15139.5 15213.7 15472.1 15868.0 15869.9 11323.3 11861.0 12012.2 12140.0 12597.9 3484.2 3495.8 3587.1 3616.5 3687.9 80879.2 81343.0 81600.0 82399.6 83251.2 11246.4 11323.0 11451.1 11527.6 11561.5 22383.3 22438.6 22699.4 22964.0 23079.4 7519.5 7703.5 7791.9 8017.1 8236.2 4366.0 4413.9 4439.4 4485.2 4666.8 3150.8 3205.1 3226.1 3453.8 3616.3 627.2 630.3 633.6 641.9 648.8 580.3 622.3 646.7 708.3 709.3 8515.8 9050.9 9069.3 9112.2 9332.0 679.5 689.0 700.8 707.0 715.5 4327.8 4341.5 4586.9 4587.7 4677.6 85786.1 85931.0 86616.0 86840.0 88043.0 56383.7 61292.0 70683.6 75422.0 77332.6 68143.3 68202.7 68561.3 69179.7 69759.7 8520.6 8545.1 8773.1 8781.2 8805.0 45378.7 45498.0 46916.1 47280.5 47474.4 59591.7 61006.0 64583.4 65676.0 66043.3 12668.9 12698.6 12990.4 13105.3 13752.6 14421.9 14619.9 15131.6 15262.2 16090.3 13297.6 13491.3 13685.6 14370.6 14493.5 13361.3 13964.7 14324.1 14431.9 14981.6 12533.7 13108.0 14079.6 14092.3 14600.9 11125.3 11305.9 11761.2 11817.4 12359.9 9683.5 10463.8 12130.2 12272.9 12451.4 02:28:43 INFO - PROCESS | 27264 | -------- Summary: end -------- 02:28:43 INFO - PROCESS | 27264 | 02:28:44 INFO - TEST-INFO | 27264: exit 0 02:28:44 INFO - TEST-OK | dromaeo_css | took 1116397ms 02:28:44 INFO - TEST-START | kraken 02:28:44 INFO - operating with platform_type : linux_ 02:28:44 INFO - Initialising browser for kraken test... 02:28:44 INFO - TEST-INFO | started process 27632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ASTIr/profile http://localhost:49237/getInfo.html) 02:28:48 INFO - PROCESS | 27632 | __metrics Screen width/height:1600/1200 02:28:48 INFO - PROCESS | 27632 | colorDepth:24 02:28:48 INFO - PROCESS | 27632 | Browser inner width/height: 1024/697 02:28:48 INFO - PROCESS | 27632 | __metrics 02:28:49 ERROR - PROCESS | 27632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 02:28:50 INFO - TEST-INFO | 27632: exit 0 02:28:50 INFO - Browser initialized. 02:28:50 INFO - Running cycle 1/1 for kraken test... 02:28:50 INFO - TEST-INFO | started process 27756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ASTIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:02 INFO - PROCESS | 27756 | RSS: Main: 184729600 02:29:02 INFO - PROCESS | 27756 | 02:29:05 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:06 INFO - PROCESS | 27756 | RSS: Main: 193171456 02:29:06 INFO - PROCESS | 27756 | 02:29:08 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 02:29:09 INFO - PROCESS | 27756 | RSS: Main: 195739648 02:29:09 INFO - PROCESS | 27756 | 02:29:12 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 02:29:12 INFO - PROCESS | 27756 | RSS: Main: 192536576 02:29:12 INFO - PROCESS | 27756 | 02:29:14 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 02:29:15 INFO - PROCESS | 27756 | RSS: Main: 193220608 02:29:15 INFO - PROCESS | 27756 | 02:29:17 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:18 INFO - PROCESS | 27756 | RSS: Main: 193146880 02:29:18 INFO - PROCESS | 27756 | 02:29:21 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:22 INFO - PROCESS | 27756 | RSS: Main: 197734400 02:29:22 INFO - PROCESS | 27756 | 02:29:25 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:26 INFO - PROCESS | 27756 | RSS: Main: 197668864 02:29:26 INFO - PROCESS | 27756 | 02:29:28 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 02:29:29 INFO - PROCESS | 27756 | RSS: Main: 197423104 02:29:29 INFO - PROCESS | 27756 | 02:29:31 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:31 INFO - PROCESS | 27756 | RSS: Main: 197066752 02:29:31 INFO - PROCESS | 27756 | 02:29:33 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:34 INFO - PROCESS | 27756 | RSS: Main: 197210112 02:29:34 INFO - PROCESS | 27756 | 02:29:36 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:36 INFO - PROCESS | 27756 | RSS: Main: 197349376 02:29:36 INFO - PROCESS | 27756 | 02:29:39 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:40 INFO - PROCESS | 27756 | RSS: Main: 197451776 02:29:40 INFO - PROCESS | 27756 | 02:29:43 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:43 INFO - PROCESS | 27756 | RSS: Main: 197701632 02:29:43 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 02:29:45 INFO - PROCESS | 27756 | RSS: Main: 198180864 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | __start_tp_report 02:29:45 INFO - PROCESS | 27756 | _x_x_mozilla_page_load 02:29:45 INFO - PROCESS | 27756 | _x_x_mozilla_page_load_details 02:29:45 INFO - PROCESS | 27756 | |i|pagename|runs| 02:29:45 INFO - PROCESS | 27756 | |0;ai-astar;104;113;114;112;114;113;114;115;112;112 02:29:45 INFO - PROCESS | 27756 | |1;audio-beat-detection;155;125;127;173;124;132;128;127;145;124 02:29:45 INFO - PROCESS | 27756 | |2;audio-dft;163;173;165;167;167;162;164;166;167;162 02:29:45 INFO - PROCESS | 27756 | |3;audio-fft;77;76;78;113;76;75;77;75;92;76 02:29:45 INFO - PROCESS | 27756 | |4;audio-oscillator;83;82;113;84;83;83;98;83;88;106 02:29:45 INFO - PROCESS | 27756 | |5;imaging-gaussian-blur;117;117;118;119;118;118;117;122;117;117 02:29:45 INFO - PROCESS | 27756 | |6;imaging-darkroom;148;148;148;147;148;149;146;147;154;146 02:29:45 INFO - PROCESS | 27756 | |7;imaging-desaturate;97;97;95;96;96;96;95;96;95;96 02:29:45 INFO - PROCESS | 27756 | |8;json-parse-financial;54;58;55;53;55;54;55;55;54;55 02:29:45 INFO - PROCESS | 27756 | |9;json-stringify-tinderbox;63;62;62;62;64;62;62;62;62;63 02:29:45 INFO - PROCESS | 27756 | |10;stanford-crypto-aes;85;84;81;82;83;81;81;81;82;83 02:29:45 INFO - PROCESS | 27756 | |11;stanford-crypto-ccm;140;144;141;131;145;133;139;135;181;131 02:29:45 INFO - PROCESS | 27756 | |12;stanford-crypto-pbkdf2;164;167;164;163;164;168;163;170;165;165 02:29:45 INFO - PROCESS | 27756 | |13;stanford-crypto-sha256-iterative;66;63;65;65;65;65;66;66;68;66 02:29:45 INFO - PROCESS | 27756 | __end_tp_report 02:29:45 INFO - PROCESS | 27756 | __start_cc_report 02:29:45 INFO - PROCESS | 27756 | _x_x_mozilla_cycle_collect,770 02:29:45 INFO - PROCESS | 27756 | __end_cc_report 02:29:45 INFO - PROCESS | 27756 | __startTimestamp1481192985813__endTimestamp 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | ------- Summary: start ------- 02:29:45 INFO - PROCESS | 27756 | Number of tests: 14 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.09 (2.7%) stddev-sans-first:1.09 02:29:45 INFO - PROCESS | 27756 | Values: 104.0 113.0 114.0 112.0 114.0 113.0 114.0 115.0 112.0 112.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:130.00 stddev:16.54 (12.7%) stddev-sans-first:16.05 02:29:45 INFO - PROCESS | 27756 | Values: 155.0 125.0 127.0 173.0 124.0 132.0 128.0 127.0 145.0 124.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.50 stddev:3.27 (2.0%) stddev-sans-first:3.33 02:29:45 INFO - PROCESS | 27756 | Values: 163.0 173.0 165.0 167.0 167.0 162.0 164.0 166.0 167.0 162.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:12.16 (15.9%) stddev-sans-first:12.79 02:29:45 INFO - PROCESS | 27756 | Values: 77.0 76.0 78.0 113.0 76.0 75.0 77.0 75.0 92.0 76.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.00 stddev:11.29 (13.6%) stddev-sans-first:11.67 02:29:45 INFO - PROCESS | 27756 | Values: 83.0 82.0 113.0 84.0 83.0 83.0 98.0 83.0 88.0 106.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.56 (1.3%) stddev-sans-first:1.62 02:29:45 INFO - PROCESS | 27756 | Values: 117.0 117.0 118.0 119.0 118.0 118.0 117.0 122.0 117.0 117.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:2.28 (1.5%) stddev-sans-first:2.42 02:29:45 INFO - PROCESS | 27756 | Values: 148.0 148.0 148.0 147.0 148.0 149.0 146.0 147.0 154.0 146.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 02:29:45 INFO - PROCESS | 27756 | Values: 97.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.32 (2.4%) stddev-sans-first:1.36 02:29:45 INFO - PROCESS | 27756 | Values: 54.0 58.0 55.0 53.0 55.0 54.0 55.0 55.0 54.0 55.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 02:29:45 INFO - PROCESS | 27756 | Values: 63.0 62.0 62.0 62.0 64.0 62.0 62.0 62.0 62.0 63.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.42 (1.7%) stddev-sans-first:1.12 02:29:45 INFO - PROCESS | 27756 | Values: 85.0 84.0 81.0 82.0 83.0 81.0 81.0 81.0 82.0 83.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.50 stddev:14.61 (10.4%) stddev-sans-first:15.47 02:29:45 INFO - PROCESS | 27756 | Values: 140.0 144.0 141.0 131.0 145.0 133.0 139.0 135.0 181.0 131.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:2.31 (1.4%) stddev-sans-first:2.40 02:29:45 INFO - PROCESS | 27756 | Values: 164.0 167.0 164.0 163.0 164.0 168.0 163.0 170.0 165.0 165.0 02:29:45 INFO - PROCESS | 27756 | 02:29:45 INFO - PROCESS | 27756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 02:29:45 INFO - PROCESS | 27756 | Values: 66.0 63.0 65.0 65.0 65.0 65.0 66.0 66.0 68.0 66.0 02:29:45 INFO - PROCESS | 27756 | -------- Summary: end -------- 02:29:45 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - PROCESS | 27756 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 02:29:46 INFO - PROCESS | 27756 | 02:29:46 INFO - TEST-INFO | 27756: exit 0 02:29:46 INFO - TEST-OK | kraken | took 62220ms 02:29:46 INFO - SUITE-END | took 1178s 02:29:46 INFO - Completed test suite (00:19:38) 02:29:46 INFO - javascript benchmark 02:29:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7095.491311867031, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.833458327084, 3343.6322004579506, 3362.4451965425696, 3368.427367347551, 3387.864485420583, 5323.866903327419, 5356.437574054722, 5403.648762830413, 5406.16204488304, 5446.891062178754, 5336.199570064492, 5367.597430192732, 5373.220882971967, 5398.649087809299, 5486.890262194754, 4868.221084626461, 4917.72952487613, 4943.134951383511, 5032.6477146599755, 5056.797728090872, 4956.925646115311, 5088.440271570124, 5099.184130539114, 5113.667611605252, 5123.436421993578, 4749.4775574686755, 4996.325496058058, 5023.6985780853265, 5031.144705400091, 5046.747662616873, 4826.131296366652, 4872.220444728827, 4881.389826271716, 4908.410990681141, 4933.7286449245275, 4941.45643979162, 4965.503449655042, 4975.378077740283, 4999.775010124553, 5015.548600625924, 5378.300820893259, 5385.35375754908, 5419.864503387407, 5445.128779395317, 5465.9180112298345, 5698.34469036062, 5751.022326204556, 5793.681347525884, 5818.272715910512, 5841.649501029951, 5707.4577915098, 5766.163906233573, 5775.3935836736955, 5804.738786754606, 5859.121131830259, 5369.114096174127, 5405.891882162335, 5407.594430417695, 5409.486098820606, 5412.107002344569, 5679.062954612526, 5864.266966629171, 5875.148103524965, 5884.146798714162, 5886.234789477427, 5592.664440133605, 5624.775008999594, 5667.773289068474, 5686.914696279477, 5701.942980570224, 5773.422657734193, 5784.652920824764, 5785.450382213683, 5785.942140578624, 5791.0, 5614.859628509238, 5639.830805075854, 5647.830565083054, 5657.094864821609, 5691.430856914359, 5511.559075274049, 5651.124075768263, 5712.742926568314, 5736.741846616829, 5769.48074673273, 4395.780210989502, 4427.756473393994, 4437.600615944581, 4453.376527286183, 4507.414036175342, 3977.2840888639744, 3996.300647386754, 4003.199360127986, 4038.596140385938, 4072.429859819628, 5388.164834450588, 5479.726013699299, 5483.533899618577, 5484.341878974548, 5519.172124181405, 5669.914951275734, 5685.744141513642, 5720.914186287209, 5722.799702010493, 5793.710314484259, 5419.783208671609, 5455.345358556999, 5457.126859702428, 5476.507114359647, 5480.479354461319, 4918.213085906309, 4943.233798761198, 4952.921449761386, 4954.529319714621, 4993.226049962262, 5799.971000144972, 5845.210896528914, 5852.473277405054, 5930.199423078002, 5941.257342832146, 5671.376148623731, 5711.257536520226, 5731.627444216113, 5734.54123670097, 5751.194832723506, 5980.581359304981, 6047.727852246748, 6052.515798736003, 6101.450869421773, 6111.84720381994, 5679.858003549944, 5736.196932429547, 5746.712664366682, 5753.252077229933, 5754.482096611325, 5736.971315143398, 5765.538756899522, 5821.563382746226, 5829.621074630136, 5841.853953651193, 5566.944330556805, 5623.465770751772, 5652.3217213934595, 5658.264425624642, 5675.432456754292, 5524.558035357242, 5526.751296191762, 5578.30271216098, 5637.098064309691, 5711.628744131618, 5476.91784623223, 5525.696086715269, 5550.500454958911, 5580.190872323572, 5602.159676048463, 5658.321001479849, 5665.348484924121, 5667.036603777286, 5685.971570142123, 5700.144978253295, 5396.3524377075, 5427.592930530147, 5432.592555558428, 5446.918296225481, 5524.088525393265], "value": 5334.051103028308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.8772670012597, 563.3605857351907, 576.4235764235763, 577.1371799160256, 589.8967680655884, 40840.59159408405, 42607.36088958664, 42661.57338426615, 45407.0, 45457.31814022792, 42450.7877460613, 43054.7847260764, 43073.0, 43084.56915430845, 43125.7843710781, 8539.188777066185, 8641.308695304391, 10093.293469457141, 10340.37957722539, 10355.534000969974, 10115.494225288743, 10193.133583645398, 10231.795364092713, 10232.846507302396, 10239.641612543563, 10291.63979260726, 10322.690319290434, 10332.58669653213, 10370.118539924115, 10374.170066394709, 10243.23175761817, 10245.28283020189, 10281.53733082013, 10300.0, 10323.741906452324, 10257.89742102577, 10293.176545876311, 10325.63860264887, 10343.431111288875, 10351.275410721253, 39917.60082399168, 40421.595784042074, 40452.0, 40497.190056199004, 40526.59473405287, 3612.3858943979326, 4001.679865610744, 4046.251443482965, 4059.106996460774, 4120.001799127421, 31081.37837243265, 31126.844365778026, 31222.0, 31781.6821831781, 31841.681583184105, 4005.0, 4154.979225103885, 4248.490181178278, 4401.889952751207, 4404.075144219718, 330170.0, 330204.0, 332370.99999999756, 332373.0, 333000.0, 59420.40579594235, 59483.40516594865, 59685.0, 59728.402715973156, 59827.40172598305, 62899.37100629027, 62959.370406296264, 62963.6851815738, 63154.0, 63171.36828631747, 14033.087849289763, 15327.770083448757, 15515.534533963773, 15544.378224870878, 15577.766333505006, 10634.840477392845, 11357.716057098638, 11541.76916461666, 11583.594574189863, 11893.940530297466, 18491.630167396575, 18589.163487643087, 18743.812561874478, 18793.812061879205, 18905.24379024851, 6560.606363618198, 6804.4216241620015, 6917.342852429011, 7028.543144695578, 7144.785656430211, 881.38743573216, 955.5174636808367, 1024.8360262357987, 1056.822870322961, 1084.0568705226503, 30701.692983069883, 31332.530012049836, 31354.0, 31415.37169256602, 31850.840745796122, 1093.6718984304678, 1097.401915955806, 1119.5689659481159, 1125.3472985668293, 1176.5529098942347, 16007.839921600867, 16757.0, 16833.0, 16851.325946962228, 16865.241064152142, 444872.0, 449561.0, 450270.0, 451246.0, 453479.0, 56566.7171664139, 57281.713591432606, 57330.0, 57429.42570574324, 57455.138172927436, 1239.0459346303296, 1304.8434187897512, 1308.339288659221, 1310.9475620975054, 1322.0283091927427, 29507.409851803273, 30757.538636920017, 30911.690883091782, 31065.8446707765, 31539.684603154594, 50091.74954125206, 50537.74731126321, 50556.24165637592, 50647.0, 50750.23874641957, 406489.0, 407451.0, 407933.0, 408373.0, 408730.0, 26652.46695066049, 28088.719112809427, 28465.857670711513, 28466.28834279077, 28596.857015714788, 43652.781736091114, 43984.34023489714, 44444.33333500065, 44596.0, 44673.776631116634, 36955.63044369522, 37232.81383593065, 38157.2368552633, 38367.6163238364, 38710.0, 38053.764675918894, 38331.425028624035, 38446.0, 38696.613033869304, 39870.202595948496, 38685.80657096697, 38870.0, 39912.80043599763, 41506.37740433835, 43455.13089738124, 33950.830245848614, 36398.81800591086, 36749.44875826811, 37063.07342316356, 37104.443433349064, 26793.732062679122, 27154.72845271601, 27500.17499475019, 29508.262293441978, 29598.112056638336], "value": 19957.89582551402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.88291571070846, 388.9047183440054, 404.2702921227185, 405.0925925925926, 419.8908283846201, 17774.289028438863, 18907.905460472713, 19233.134508947096, 19233.134508947096, 19674.11466484008, 18503.35238266661, 18543.721844172316, 18785.24859005638, 18844.528886777836, 18853.434396968078, 5297.735113244332, 5548.0, 5683.403242659523, 5730.484256416921, 5759.769609215627, 5604.299462567179, 5659.320881494226, 5662.17898404731, 5685.800996965107, 5704.54363650909, 5437.700926449043, 5561.694106824123, 5592.6085174037835, 5622.971885140569, 5646.040173170551, 5511.421300763423, 5580.051391263495, 5597.916031259514, 5618.325800903917, 5652.915206271889, 4896.853094407174, 5040.243963405518, 5083.567896728782, 5084.44924298089, 5091.974540127313, 22216.555668886693, 22299.108035678553, 22322.0, 22572.548549029092, 22638.0, 2054.866433681821, 2195.538936823269, 2509.372656835791, 2562.4490734492174, 2980.716831900966, 10110.342827716175, 10183.828859681158, 10604.310719803188, 12210.267383956902, 13688.110272832333, 1870.812918708132, 1926.6532024235632, 1927.108890574119, 1995.6208320419073, 2051.979480205194, 77659.0, 78022.21977780206, 79219.60390198127, 80066.5996670013, 80067.0, 10735.463226838783, 10927.235093543375, 10984.176186786022, 11129.549839549765, 11129.721756956142, 14638.268086595628, 15152.090874547563, 15153.924230378998, 15182.544523664308, 15185.468508602145, 7571.129320128146, 7581.696732130763, 7620.0, 7665.195154508808, 7801.439712057498, 7035.613041282779, 7061.823454413578, 7123.857522849514, 7253.891191632129, 7283.963580182065, 4598.701084429501, 4638.930416043762, 4695.5539223773685, 4723.220668589713, 4745.098431298043, 1927.7012063130237, 1942.1066309497508, 1984.900754962246, 2002.6168859057675, 2009.6784514477613, 882.2544949517647, 882.3514716683233, 984.2027957354422, 1010.0, 1038.813013657549, 17685.381011664787, 19143.0, 19352.516187095436, 19461.708074378897, 19477.220911163677, 959.5777857742571, 962.1821451765943, 979.8187335342984, 1013.0376142664499, 1030.0111892583204, 10283.588656453807, 10760.838587421194, 10812.135029197645, 10860.348379097279, 10891.0, 400697.0, 408752.0, 408879.0, 409814.0, 412621.0, 81621.59189204135, 84269.57865210634, 86108.56945715232, 86371.0, 86872.0, 731.5500966905315, 744.5346658338539, 759.7644730133676, 919.3977944446399, 921.1663444582664, 16481.587960301087, 16592.83407165913, 17022.319107236068, 17425.47723568295, 17500.82499174992, 40711.79644101761, 40939.38590921198, 41507.16985660209, 41769.58230417657, 42723.0, 52572.9485410282, 54626.0, 55284.0, 55665.44334556765, 57224.71387643035, 8266.669333226604, 8275.95862020686, 8419.663213471393, 8572.099929507312, 8617.913820861711, 9428.15146636806, 12056.51773929068, 12525.686857828627, 12756.0, 12899.613011609667, 10478.266521343432, 10802.459877006275, 10825.296355736851, 10865.782684346426, 11507.597234096766, 11290.943545282222, 11325.263857849213, 11491.48288327044, 11707.180497365443, 11841.881581184078, 11413.0, 11500.48247828833, 11745.0, 11888.0, 12189.939050304693, 8301.750947471586, 8419.115992820665, 8468.44955077918, 8656.567171641518, 8772.29821614282, 9506.382085164441, 11602.593909213474, 11875.168738188244, 11921.463534141158, 12172.634820955385], "value": 8940.09202423114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.709211065676, 1421.9644508887277, 1460.4669295707063, 1586.4050980882168, 1610.0822531157246, 7816.921830781691, 8068.757937261877, 8271.875921861169, 8302.045264794551, 8322.83354332913, 8240.7939801505, 8384.664613415456, 8388.83222335553, 8389.0, 8413.579321033954, 2265.4676151104436, 2311.9884400577976, 2327.2552783109327, 2332.4635333873134, 2334.8248881333884, 2321.94195145121, 2348.283773449097, 2365.60967440373, 2377.132346693462, 2387.3076807725824, 2293.7706229377095, 2299.540091981602, 2319.512902290521, 2321.5472982768365, 2327.674125622406, 2269.2994641794103, 2273.056681477185, 2297.655351697242, 2298.0118549023914, 2302.7236731592234, 2238.160689741347, 2268.0247493577754, 2290.358699564125, 2291.0950174681075, 2291.942701432461, 8258.380621453354, 8274.503529788231, 8374.371922105805, 8396.244338009546, 8401.831963360699, 4873.780679869379, 4913.361263035818, 4954.702717836942, 4969.850904472872, 5017.799288028475, 3062.38752249551, 3064.417760625474, 3287.2932319551173, 3291.901242962715, 3292.42382583047, 1026.5226669598599, 1045.3518818332682, 1075.7256899490658, 1088.4122573810212, 1092.918031147667, 11069.114470842394, 11073.944630276797, 11075.778484430266, 11153.498092585773, 11181.385023823768, 4147.771872547039, 4258.1057977824385, 4323.0, 4332.0, 4446.0, 9040.683576074805, 9043.68347107848, 9051.547422628842, 9059.864102038475, 9069.31980101495, 4942.678725882806, 4973.5523802857915, 4976.701397916137, 4976.90046199074, 4980.153373926441, 4501.977490112528, 4538.092381523708, 4666.253399456139, 4705.694129881546, 4744.501827308152, 3591.9102022449124, 3707.4068149096015, 3715.461258117558, 3759.7180211484247, 3767.6232376762105, 1136.6362763915633, 1139.6865861888048, 1148.0757989818276, 1148.4372657397814, 1172.302480024384, 797.8045378882211, 945.7257395355407, 951.9333646644807, 960.6925783749133, 982.7641366072091, 5374.731263436813, 5496.038193316233, 5565.191312823267, 5655.800981149056, 5770.480656740913, 445.7414699474297, 447.4630443467852, 449.6200710399707, 460.39688008708697, 461.47852926193184, 3797.6202379762353, 3854.3257915399845, 3904.707146963989, 3909.58949310324, 3910.9217815644097, 9520.000399958044, 9780.41317520951, 9875.703728888146, 9878.851817222603, 9977.750556236153, 9734.902650973541, 9764.218862490983, 9799.804003919882, 9822.066903644143, 9845.901540984498, 7486.5508069516, 7556.924430755732, 7621.466497345133, 7641.235876412315, 7650.196729343339, 5405.324334458192, 5439.48324909133, 5439.619226654097, 5536.640118392292, 5599.1041433370465, 8884.600192991202, 8887.73336799897, 8909.955450222707, 9013.18881300686, 9063.456192628464, 9085.409448385833, 9232.03063678331, 9239.491827949527, 9255.167034966886, 9483.857742134012, 6669.899951500634, 6860.48546359035, 7055.6472176392, 7372.373348265458, 7536.773896783106, 7822.726204582812, 8153.470024448392, 8166.918330816616, 8169.714060007871, 8187.345012399113, 7187.604681742554, 7262.9273707262255, 7438.62806859644, 7442.032535770315, 7457.664405101675, 6972.51192416526, 7088.0, 7117.501774875709, 7245.094363204599, 7318.268173182639, 6517.315681853337, 6550.148480697479, 6561.245456772533, 6564.606123632598, 6608.966955165193, 4705.34125222476, 4822.903541929071, 4847.80608775645, 4864.635152363516, 4890.510948905223, 4835.323054772264, 4895.6817806843865, 4928.359313289393, 5002.599792016703, 5059.747012649426], "value": 4286.8652348166615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.87922908138523, 336.7709957229083, 340.50966608084343, 341.1114047905207, 351.7942003927702, 5444.482774136461, 5485.314335708036, 5522.972385138079, 5538.556915446765, 5562.471565201309, 5377.247185394038, 5396.91904621431, 5413.783448662059, 5442.074847275962, 5481.698506582136, 4247.06564555798, 4295.226859165349, 4312.2453570625175, 4322.832835134512, 4325.718828276152, 4076.408920706496, 4219.092895027568, 4283.7215580987295, 4305.3541968704785, 4340.65274778017, 4210.642095421893, 4222.809973551182, 4232.640225580829, 4232.746035237896, 4245.118114168716, 4205.0, 4216.346466297744, 4216.810243539048, 4228.76741779202, 4233.23801715691, 3735.5431381761136, 3741.6258374162367, 3753.981230093832, 3754.8498060077563, 3760.793156376398, 5122.847359344155, 5279.63042587019, 5303.700593354614, 5307.929907336142, 5331.413544510101, 4822.927656085161, 4837.467878533358, 4849.321095046696, 4859.41686997559, 4872.756362181912, 5432.483914028161, 5578.330600327987, 5681.261436013333, 5682.54539636828, 5713.371529131834, 4071.2671719090554, 4093.421144678863, 4096.160287141129, 4105.2405305018665, 4127.422160897477, 5933.525317974595, 5950.97024514879, 5971.4327138921735, 5980.491658209057, 5981.371955944606, 3972.980135099364, 4182.853600123981, 4193.811278492475, 4195.1819395217635, 4214.64175545076, 4165.229777344677, 4202.222588821078, 4220.746755194698, 4228.6617070634275, 4249.2988656871885, 4858.562729354375, 4875.07373599015, 4893.140606569481, 4895.0, 4906.190478571068, 5488.670679759148, 5771.220885180447, 5797.565182611321, 5826.621269617462, 5873.913326034697, 1409.9647508812157, 1423.395057100728, 1425.0, 1427.7715565509468, 1431.8854491640643, 921.3872774604813, 948.672707915768, 951.5622813505727, 973.9773238099966, 977.8875429325718, 5369.7583608737705, 5376.489233522809, 5381.623286369917, 5391.299131113009, 5399.433059528771, 5656.604037717402, 5699.800506982236, 5702.258706368146, 5712.343080545707, 5716.228309178291, 5169.327987361694, 5318.468153184651, 5332.533553272881, 5408.756605952742, 5416.729163541807, 2942.6174597302215, 2954.7691492922704, 2978.6298302780965, 3017.9396412071637, 3023.6220472440946, 5837.503812175928, 5854.502367298742, 5903.852403689856, 5913.645181289136, 5957.970210148921, 5636.4927156556105, 5984.581079324493, 5992.31088424828, 6003.249593800775, 6054.182685337511, 6145.600535965148, 6172.753089876354, 6185.969070154621, 6193.84515387119, 6218.626882387071, 5576.386597474356, 5801.216835727123, 5803.9419605803405, 5820.243368362086, 5838.503727183067, 5795.478406943395, 5828.271466066742, 5861.296644402699, 5871.119332100219, 5874.647521148745, 5871.94128058714, 6093.512518998558, 6197.690115494117, 6206.751729930752, 6226.968865155645, 3954.1696243789124, 4065.5809793173016, 4094.6519545838937, 4118.320477121241, 4123.876283711494, 5840.0, 5864.44287792659, 5874.970625147018, 5878.178474332259, 5878.617889837147, 5572.916406253828, 5730.71346432685, 5734.340550836707, 5736.483716465538, 5752.597318187687, 5643.858903527444, 5675.120356344773, 5676.574256930664, 5684.436779885565, 5711.714414279352, 5647.1529270609735, 5654.7455364509515, 5667.3482549507335, 5701.949457040463, 5717.599768016199, 5517.586181036358, 5673.858153546194, 5677.914831277617, 5723.828285151452, 5805.896879592864, 5623.690697011703, 5624.943750562442, 5634.408387119293, 5638.9436105638415, 5652.915206271991], "value": 4340.382104821816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.46251042973, 732.9413646908248, 750.9336741826605, 769.4075561817401, 789.9131095579481, 14600.269986500673, 15355.692886142284, 15442.459513917001, 15446.84553154468, 15480.845191548082, 14166.433342666282, 14293.070950388217, 14307.928460357709, 14317.427302907898, 14318.92840535796, 627.0, 644.7485480662522, 743.0, 749.232037161908, 758.2303961479104, 753.130134694426, 760.3536993555462, 762.2073044034225, 762.4929421934435, 762.5691484311374, 809.2069771623812, 811.7077851973285, 813.1461964936822, 813.4387272781792, 813.7640084375524, 803.1807556292578, 807.0718673525434, 808.1191501263621, 810.1776696652902, 813.158381075584, 592.5851903667407, 593.4510577715639, 593.7476572456688, 594.111802854735, 596.1802521532892, 14930.25348732559, 15003.1748253846, 15034.624134396727, 15053.0, 15655.843441565552, 15139.545813625498, 15213.676921693464, 15472.14903180336, 15868.0, 15869.920650396674, 11323.320600763898, 11861.0, 12012.159148859584, 12140.0, 12597.874021259762, 3484.163800687842, 3495.755297129202, 3587.121155316964, 3616.5479315085613, 3687.944680829763, 80879.19120808835, 81343.0, 81600.0, 82399.58800205961, 83251.16748832495, 11246.381449020382, 11323.0, 11451.141164412702, 11527.596534121265, 11561.479733412016, 22383.32850014502, 22438.551228975328, 22699.432514187276, 22964.0, 23079.42301442444, 7519.548827070394, 7703.499272547267, 7791.883121753178, 8017.118117007125, 8236.217559331853, 4365.978170109129, 4413.911721765547, 4439.378487011821, 4485.237509623372, 4666.789994450258, 3150.8109513429267, 3205.0705295464054, 3226.080567038383, 3453.7755045921936, 3616.3129005488872, 627.1877918096077, 630.3192552043873, 633.6451587111233, 641.868416974519, 648.8053583924803, 580.2659635561018, 622.2501885228289, 646.6880900779731, 708.2775568919776, 709.2800807180715, 8515.829683406297, 9050.86423703645, 9069.274458043341, 9112.225460835904, 9331.953340233391, 679.4564348521163, 688.9655517224219, 700.765243643375, 707.0, 715.5456285258898, 4327.8485253016, 4341.45731783527, 4586.862394128181, 4587.747673877902, 4677.602403795716, 85786.14213857906, 85931.0, 86616.0, 86840.0, 88043.0, 56383.71808140933, 61292.0, 70683.6465817678, 75422.0, 77332.61333693408, 68143.31856681469, 68202.65898670474, 68561.3143868565, 69179.65410172917, 69759.65120174366, 8520.616572254388, 8545.145485451405, 8773.122687731431, 8781.165789250012, 8804.987600712859, 45378.731063447354, 45498.0, 46916.06167876691, 47280.52719472761, 47474.38890860898, 59591.702041489516, 61006.0, 64583.35416645961, 65676.0, 66043.33956660565, 12668.936655317033, 12698.619041428772, 12990.35048247565, 13105.27920964356, 13752.587422377344, 14421.855781442051, 14619.903507236788, 15131.621709457351, 15262.23688815577, 16090.275937582603, 13297.601071967856, 13491.257980810757, 13685.589432317047, 14370.640733981734, 14493.492727754478, 13361.26513041753, 13964.650883727989, 14324.068935519157, 14431.927840360731, 14981.550553483414, 12533.686657833627, 13108.0, 14079.577612671636, 14092.295385230493, 14600.904932130345, 11125.276857004268, 11305.943470282926, 11761.235519691192, 11817.409129543661, 12359.938200308941, 9683.518615678426, 10463.790724185626, 12130.170177518286, 12272.938635307124, 12451.377431128589], "value": 7205.547498976111, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 112.0, 114.0, 113.0, 114.0, 115.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 127.0, 173.0, 124.0, 132.0, 128.0, 127.0, 145.0, 124.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 165.0, 167.0, 167.0, 162.0, 164.0, 166.0, 167.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 113.0, 76.0, 75.0, 77.0, 75.0, 92.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 113.0, 84.0, 83.0, 83.0, 98.0, 83.0, 88.0, 106.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 122.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 146.0, 147.0, 154.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 53.0, 55.0, 54.0, 55.0, 55.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 81.0, 82.0, 83.0, 81.0, 81.0, 81.0, 82.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 141.0, 131.0, 145.0, 133.0, 139.0, 135.0, 181.0, 131.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 163.0, 164.0, 168.0, 163.0, 170.0, 165.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 68.0, 66.0], "value": 65.5, "unit": "score"}]}]} 02:29:47 INFO - Return code: 0 02:29:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:29:47 ERROR - # TBPL SUCCESS # 02:29:47 INFO - Running post-action listener: _resource_record_post_action 02:29:47 INFO - [mozharness: 2016-12-08 10:29:47.121049Z] Finished run-tests step (success) 02:29:47 INFO - Running post-run listener: _resource_record_post_run 02:29:47 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290029568; Read time: 16; Write time: 200860 02:29:47 INFO - TinderboxPrint: CPU usage
13.4% 02:29:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:29:47 INFO - TinderboxPrint: I/O write bytes / time
290,029,568 / 200,860 02:29:47 INFO - TinderboxPrint: CPU idle
8,255.7 (86.5%) 02:29:47 INFO - TinderboxPrint: CPU user
1,222.0 (12.8%) 02:29:47 INFO - TinderboxPrint: Swap in / out
0 / 0 02:29:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1069056; Read time: 0; Write time: 60 02:29:47 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288260096; Read time: 0; Write time: 200432 02:29:47 INFO - Running post-run listener: _upload_blobber_files 02:29:47 INFO - Blob upload gear active. 02:29:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:47 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 02:29:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:29:47 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:29:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:48 INFO - (blobuploader) - INFO - Done attempting. 02:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:52 INFO - (blobuploader) - INFO - Done attempting. 02:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:53 INFO - (blobuploader) - INFO - Done attempting. 02:29:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:53 INFO - Return code: 0 02:29:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:29:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dce50305abc46e7a2af1a31f4e8a18ae84a37b309a3e2c834273a150ef6060187c8561ce8254dc21d536540fc6afa7f828816f48e7a8e16c2c75a5ccd2d5980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b8f697e7c41028a76c5b56d4f6cd492b6c3b84757a7fe9be389cd729cc4801428527dbde546303f0f6ce131394c5aa2b6f3b5da81cebe12f310880bb9fb5506", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3ffb4082a7f52e456b628c39d62710d61a6928c349b608a41766980930819b59c9a0173de59b2a8ecc1cde9ffe0cdfa9b1751a52dbd40b834d76509207772b6"} 02:29:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:29:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:29:53 INFO - Contents: 02:29:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dce50305abc46e7a2af1a31f4e8a18ae84a37b309a3e2c834273a150ef6060187c8561ce8254dc21d536540fc6afa7f828816f48e7a8e16c2c75a5ccd2d5980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b8f697e7c41028a76c5b56d4f6cd492b6c3b84757a7fe9be389cd729cc4801428527dbde546303f0f6ce131394c5aa2b6f3b5da81cebe12f310880bb9fb5506", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3ffb4082a7f52e456b628c39d62710d61a6928c349b608a41766980930819b59c9a0173de59b2a8ecc1cde9ffe0cdfa9b1751a52dbd40b834d76509207772b6"} 02:29:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:53 INFO - Copying logs to upload dir... 02:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:29:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.156436 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-08 02:29:52.971293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 02:29:52.975038) ========= 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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dce50305abc46e7a2af1a31f4e8a18ae84a37b309a3e2c834273a150ef6060187c8561ce8254dc21d536540fc6afa7f828816f48e7a8e16c2c75a5ccd2d5980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b8f697e7c41028a76c5b56d4f6cd492b6c3b84757a7fe9be389cd729cc4801428527dbde546303f0f6ce131394c5aa2b6f3b5da81cebe12f310880bb9fb5506", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3ffb4082a7f52e456b628c39d62710d61a6928c349b608a41766980930819b59c9a0173de59b2a8ecc1cde9ffe0cdfa9b1751a52dbd40b834d76509207772b6"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481185803/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dce50305abc46e7a2af1a31f4e8a18ae84a37b309a3e2c834273a150ef6060187c8561ce8254dc21d536540fc6afa7f828816f48e7a8e16c2c75a5ccd2d5980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b8f697e7c41028a76c5b56d4f6cd492b6c3b84757a7fe9be389cd729cc4801428527dbde546303f0f6ce131394c5aa2b6f3b5da81cebe12f310880bb9fb5506", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3ffb4082a7f52e456b628c39d62710d61a6928c349b608a41766980930819b59c9a0173de59b2a8ecc1cde9ffe0cdfa9b1751a52dbd40b834d76509207772b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 02:29:53.000613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:29:53.000948) ========= 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=826874ccc97bd7bf541b4875000001d5-1481191734.618982-1966299277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 02:29:53.086056) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 02:29:53.086407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 02:29:53.086733) ========= ========= Total master_lag: 0.16 =========