builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1484075981.23 results: success (0) buildid: 20170110111924 builduid: a96660293555455c915217e608fcf868 revision: 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.226472) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.226856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.227130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.251256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.251500) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 11:19:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.7M=0s 2017-01-10 11:19:41 (68.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.336883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.337161) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020167 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.387640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:41.387949) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 --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 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 --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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 11:19:41,550 truncating revision to first 12 chars 2017-01-10 11:19:41,550 Setting DEBUG logging. 2017-01-10 11:19:41,550 attempt 1/10 2017-01-10 11:19:41,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/36e0e97d1c1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 11:19:41,851 unpacking tar archive at: mozilla-inbound-36e0e97d1c1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:42.058239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:42.058580) ========= script_repo_revision: 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:42.059054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:42.059331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 11:19:42.071391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-10 11:19:42.071680) ========= /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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:19:42 INFO - MultiFileLogger online at 20170110 11:19:42 in /builds/slave/test 11:19:42 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 11:19:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:19:42 INFO - {'append_to_log': False, 11:19:42 INFO - 'base_work_dir': '/builds/slave/test', 11:19:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:19:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:19:42 INFO - 'branch': 'Mozilla-Inbound', 11:19:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:19:42 INFO - 'config_files': ('talos/linux_config.py',), 11:19:42 INFO - 'default_actions': ('clobber', 11:19:42 INFO - 'read-buildbot-config', 11:19:42 INFO - 'download-and-extract', 11:19:42 INFO - 'populate-webroot', 11:19:42 INFO - 'create-virtualenv', 11:19:42 INFO - 'install', 11:19:42 INFO - 'run-tests'), 11:19:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:19:42 INFO - 'download_minidump_stackwalk': True, 11:19:42 INFO - 'download_symbols': 'ondemand', 11:19:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:19:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:19:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:19:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:19:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:19:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:19:42 INFO - 'installer_path': 'installer.exe', 11:19:42 INFO - 'log_level': 'info', 11:19:42 INFO - 'log_name': 'talos', 11:19:42 INFO - 'log_to_console': True, 11:19:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:19:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:19:42 INFO - 'opt_config_files': (), 11:19:42 INFO - 'pip_index': False, 11:19:42 INFO - 'sps_profile': False, 11:19:42 INFO - 'sps_profile_interval': 0, 11:19:42 INFO - 'suite': 'dromaeojs-e10s', 11:19:42 INFO - 'system_bits': '32', 11:19:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:19:42 INFO - 'title': 'talos-linux64-ix-014', 11:19:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:19:42 INFO - 'use_talos_json': True, 11:19:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:19:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:19:42 INFO - 'work_dir': 'build'} 11:19:42 INFO - [mozharness: 2017-01-10 19:19:42.329048Z] Running clobber step. 11:19:42 INFO - Running pre-action listener: _resource_record_pre_action 11:19:42 INFO - Running main action method: clobber 11:19:42 INFO - rmtree: /builds/slave/test/build 11:19:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:19:43 INFO - Running post-action listener: _resource_record_post_action 11:19:43 INFO - [mozharness: 2017-01-10 19:19:43.308350Z] Finished clobber step (success) 11:19:43 INFO - [mozharness: 2017-01-10 19:19:43.308451Z] Running read-buildbot-config step. 11:19:43 INFO - Running pre-action listener: _resource_record_pre_action 11:19:43 INFO - Running main action method: read_buildbot_config 11:19:43 INFO - Using buildbot properties: 11:19:43 INFO - { 11:19:43 INFO - "project": "", 11:19:43 INFO - "product": "firefox", 11:19:43 INFO - "script_repo_revision": "production", 11:19:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:19:43 INFO - "repository": "", 11:19:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:19:43 INFO - "buildid": "20170110111924", 11:19:43 INFO - "stage_platform": "linux64-pgo", 11:19:43 INFO - "basedir": "/builds/slave/test", 11:19:43 INFO - "buildnumber": 2439, 11:19:43 INFO - "platform": "ubuntu64_hw", 11:19:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:19:43 INFO - "slavebuilddir": "test", 11:19:43 INFO - "branch": "mozilla-inbound", 11:19:43 INFO - "revision": "36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676", 11:19:43 INFO - "slavename": "talos-linux64-ix-014", 11:19:43 INFO - "builduid": "a96660293555455c915217e608fcf868", 11:19:43 INFO - "repo_path": "integration/mozilla-inbound" 11:19:43 INFO - } 11:19:43 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:19:43 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:19:43 INFO - Running post-action listener: _resource_record_post_action 11:19:43 INFO - [mozharness: 2017-01-10 19:19:43.310838Z] Finished read-buildbot-config step (success) 11:19:43 INFO - [mozharness: 2017-01-10 19:19:43.310929Z] Running download-and-extract step. 11:19:43 INFO - Running pre-action listener: _resource_record_pre_action 11:19:43 INFO - Running main action method: download_and_extract 11:19:43 INFO - mkdir: /builds/slave/test/build/tests 11:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:19:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/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 11:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/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 11:19:43 INFO - Downloaded 1361 bytes. 11:19:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:19:43 INFO - Using the following test package requirements: 11:19:43 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:43 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:19:43 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:19:43 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'jsshell-linux-x86_64.zip'], 11:19:43 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:19:43 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:43 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:19:43 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:19:43 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:19:43 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:19:43 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:19:43 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:19:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:19:44 INFO - Expected file size: 21849406 11:19:44 INFO - Obtained file size: 21849406 11:19:48 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 11:19:48 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:19:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:19:49 INFO - Expected file size: 21849406 11:19:49 INFO - Obtained file size: 21849406 11:19:53 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:19:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:19:59 INFO - Expected file size: 14403529 11:19:59 INFO - Obtained file size: 14403529 11:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:59 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:19:59 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/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 11:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/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 11:20:06 INFO - Downloaded 61494298 bytes. 11:20:06 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:20:06 INFO - mkdir: /builds/slave/test/properties 11:20:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:07 INFO - Contents: 11:20:07 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:20:07 INFO - Running post-action listener: _resource_record_post_action 11:20:07 INFO - Running post-action listener: set_extra_try_arguments 11:20:07 INFO - [mozharness: 2017-01-10 19:20:07.425980Z] Finished download-and-extract step (success) 11:20:07 INFO - [mozharness: 2017-01-10 19:20:07.426209Z] Running populate-webroot step. 11:20:07 INFO - Running pre-action listener: _resource_record_pre_action 11:20:07 INFO - Running main action method: populate_webroot 11:20:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:07 INFO - '--tppagecycles', 11:20:07 INFO - '7'], 11:20:07 INFO - 'tests': ['tsvgm']}}, 11:20:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['damp', 'tps']}, 11:20:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'tests': ['damp', 'tps']}, 11:20:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['dromaeo_dom']}, 11:20:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['basic_compositor_video']}, 11:20:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['a11yr', 11:20:07 INFO - 'ts_paint', 11:20:07 INFO - 'tpaint', 11:20:07 INFO - 'sessionrestore', 11:20:07 INFO - 'sessionrestore_no_auto_restore', 11:20:07 INFO - 'tabpaint']}, 11:20:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['tsvgx', 11:20:07 INFO - 'tsvgr_opacity', 11:20:07 INFO - 'tart', 11:20:07 INFO - 'tscrollx', 11:20:07 INFO - 'cart', 11:20:07 INFO - 'tsvg_static']}, 11:20:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:07 INFO - 'tsvgr_opacity', 11:20:07 INFO - 'tart', 11:20:07 INFO - 'tscrollx', 11:20:07 INFO - 'cart', 11:20:07 INFO - 'tsvg_static']}, 11:20:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'talos_options': ['--disable-e10s'], 11:20:07 INFO - 'tests': ['tp5o']}, 11:20:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'talos_options': ['--disable-e10s', 11:20:07 INFO - '--xperf_path', 11:20:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:07 INFO - 'tests': ['tp5n']}, 11:20:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:07 INFO - 'talos_options': ['--xperf_path', 11:20:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:07 INFO - 'tests': ['tp5n']}}, 11:20:07 INFO - 'talos.zip': {'path': '', 11:20:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:07 INFO - Running post-action listener: _resource_record_post_action 11:20:07 INFO - [mozharness: 2017-01-10 19:20:07.441389Z] Finished populate-webroot step (success) 11:20:07 INFO - [mozharness: 2017-01-10 19:20:07.441478Z] Running create-virtualenv step. 11:20:07 INFO - Running pre-action listener: _resource_record_pre_action 11:20:07 INFO - Running main action method: create_virtualenv 11:20:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:07 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 11:20:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:07 INFO - Using real prefix '/usr' 11:20:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:10 INFO - Installing pip.................done. 11:20:10 INFO - Return code: 0 11:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:10 INFO - Reading from file tmpfile_stdout 11:20:10 INFO - Output received: 11:20:10 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) 11:20:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:10 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:10 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 11:20:10 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 11:20:10 INFO - Using env: {'DISPLAY': ':0', 11:20:10 INFO - 'HOME': '/home/cltbld', 11:20:10 INFO - 'LANG': 'en_US.UTF-8', 11:20:10 INFO - 'LANGUAGE': 'en_US:en', 11:20:10 INFO - 'LOGNAME': 'cltbld', 11:20:10 INFO - 'MAIL': '/var/mail/cltbld', 11:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:10 INFO - 'MOZ_NO_REMOTE': '1', 11:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:10 INFO - 'NO_EM_RESTART': '1', 11:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:10 INFO - 'PWD': '/builds/slave/test', 11:20:10 INFO - 'SHELL': '/bin/bash', 11:20:10 INFO - 'SHLVL': '1', 11:20:10 INFO - 'TERM': 'linux', 11:20:10 INFO - 'TMOUT': '86400', 11:20:10 INFO - 'USER': 'cltbld', 11:20:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:10 INFO - '_': '/tools/buildbot/bin/python'} 11:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:10 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 11:20:10 INFO - Cleaning up... 11:20:10 INFO - Return code: 0 11:20:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:10 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:10 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 11:20:10 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 11:20:10 INFO - Using env: {'DISPLAY': ':0', 11:20:10 INFO - 'HOME': '/home/cltbld', 11:20:10 INFO - 'LANG': 'en_US.UTF-8', 11:20:10 INFO - 'LANGUAGE': 'en_US:en', 11:20:10 INFO - 'LOGNAME': 'cltbld', 11:20:10 INFO - 'MAIL': '/var/mail/cltbld', 11:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:10 INFO - 'MOZ_NO_REMOTE': '1', 11:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:10 INFO - 'NO_EM_RESTART': '1', 11:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:10 INFO - 'PWD': '/builds/slave/test', 11:20:10 INFO - 'SHELL': '/bin/bash', 11:20:10 INFO - 'SHLVL': '1', 11:20:10 INFO - 'TERM': 'linux', 11:20:10 INFO - 'TMOUT': '86400', 11:20:10 INFO - 'USER': 'cltbld', 11:20:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:10 INFO - '_': '/tools/buildbot/bin/python'} 11:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:10 INFO - Downloading/unpacking psutil>=3.1.1 11:20:10 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 11:20:10 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 11:20:10 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 11:20:10 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 11:20:10 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 11:20:10 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 11:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:12 INFO - Installing collected packages: psutil 11:20:12 INFO - Running setup.py install for psutil 11:20:12 INFO - building 'psutil._psutil_linux' extension 11:20:12 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 11:20:13 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 11:20:13 INFO - building 'psutil._psutil_posix' extension 11:20:13 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 11:20:13 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 11:20:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:13 INFO - Successfully installed psutil 11:20:13 INFO - Cleaning up... 11:20:13 INFO - Return code: 0 11:20:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:13 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')]} 11:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:13 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')]} 11:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:13 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:13 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 11:20:13 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 11:20:13 INFO - Using env: {'DISPLAY': ':0', 11:20:13 INFO - 'HOME': '/home/cltbld', 11:20:13 INFO - 'LANG': 'en_US.UTF-8', 11:20:13 INFO - 'LANGUAGE': 'en_US:en', 11:20:13 INFO - 'LOGNAME': 'cltbld', 11:20:13 INFO - 'MAIL': '/var/mail/cltbld', 11:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:13 INFO - 'MOZ_NO_REMOTE': '1', 11:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:13 INFO - 'NO_EM_RESTART': '1', 11:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:13 INFO - 'PWD': '/builds/slave/test', 11:20:13 INFO - 'SHELL': '/bin/bash', 11:20:13 INFO - 'SHLVL': '1', 11:20:13 INFO - 'TERM': 'linux', 11:20:13 INFO - 'TMOUT': '86400', 11:20:13 INFO - 'USER': 'cltbld', 11:20:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:13 INFO - '_': '/tools/buildbot/bin/python'} 11:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:13 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 11:20:13 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 11:20:13 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 11:20:13 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 11:20:13 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 11:20:13 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 11:20:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:15 INFO - Installing collected packages: mozsystemmonitor 11:20:15 INFO - Running setup.py install for mozsystemmonitor 11:20:15 INFO - Successfully installed mozsystemmonitor 11:20:15 INFO - Cleaning up... 11:20:15 INFO - Return code: 0 11:20:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:15 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')]} 11:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:15 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')]} 11:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:15 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:15 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 11:20:15 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 11:20:15 INFO - Using env: {'DISPLAY': ':0', 11:20:15 INFO - 'HOME': '/home/cltbld', 11:20:15 INFO - 'LANG': 'en_US.UTF-8', 11:20:15 INFO - 'LANGUAGE': 'en_US:en', 11:20:15 INFO - 'LOGNAME': 'cltbld', 11:20:15 INFO - 'MAIL': '/var/mail/cltbld', 11:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:15 INFO - 'MOZ_NO_REMOTE': '1', 11:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:15 INFO - 'NO_EM_RESTART': '1', 11:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:15 INFO - 'PWD': '/builds/slave/test', 11:20:15 INFO - 'SHELL': '/bin/bash', 11:20:15 INFO - 'SHLVL': '1', 11:20:15 INFO - 'TERM': 'linux', 11:20:15 INFO - 'TMOUT': '86400', 11:20:15 INFO - 'USER': 'cltbld', 11:20:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:15 INFO - '_': '/tools/buildbot/bin/python'} 11:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:15 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:15 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 11:20:15 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 11:20:15 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 11:20:15 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 11:20:15 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 11:20:15 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 11:20:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:18 INFO - warning: no files found matching '*.txt' 11:20:18 INFO - no previously-included directories found matching 'build' 11:20:18 INFO - no previously-included directories found matching 'dist' 11:20:18 INFO - no previously-included directories found matching '.git*' 11:20:18 INFO - Installing collected packages: jsonschema, functools32 11:20:18 INFO - Running setup.py install for functools32 11:20:18 INFO - warning: no files found matching '*.txt' 11:20:18 INFO - no previously-included directories found matching 'build' 11:20:18 INFO - no previously-included directories found matching 'dist' 11:20:18 INFO - no previously-included directories found matching '.git*' 11:20:18 INFO - Successfully installed jsonschema functools32 11:20:18 INFO - Cleaning up... 11:20:18 INFO - Return code: 0 11:20:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:18 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')]} 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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')]} 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:18 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 11:20:18 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 11:20:18 INFO - Using env: {'DISPLAY': ':0', 11:20:18 INFO - 'HOME': '/home/cltbld', 11:20:18 INFO - 'LANG': 'en_US.UTF-8', 11:20:18 INFO - 'LANGUAGE': 'en_US:en', 11:20:18 INFO - 'LOGNAME': 'cltbld', 11:20:18 INFO - 'MAIL': '/var/mail/cltbld', 11:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:18 INFO - 'MOZ_NO_REMOTE': '1', 11:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:18 INFO - 'NO_EM_RESTART': '1', 11:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:18 INFO - 'PWD': '/builds/slave/test', 11:20:18 INFO - 'SHELL': '/bin/bash', 11:20:18 INFO - 'SHLVL': '1', 11:20:18 INFO - 'TERM': 'linux', 11:20:18 INFO - 'TMOUT': '86400', 11:20:18 INFO - 'USER': 'cltbld', 11:20:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:18 INFO - '_': '/tools/buildbot/bin/python'} 11:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:18 INFO - Cleaning up... 11:20:18 INFO - Return code: 0 11:20:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:18 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')]} 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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')]} 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:18 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 11:20:18 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 11:20:18 INFO - Using env: {'DISPLAY': ':0', 11:20:18 INFO - 'HOME': '/home/cltbld', 11:20:18 INFO - 'LANG': 'en_US.UTF-8', 11:20:18 INFO - 'LANGUAGE': 'en_US:en', 11:20:18 INFO - 'LOGNAME': 'cltbld', 11:20:18 INFO - 'MAIL': '/var/mail/cltbld', 11:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:18 INFO - 'MOZ_NO_REMOTE': '1', 11:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:18 INFO - 'NO_EM_RESTART': '1', 11:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:18 INFO - 'PWD': '/builds/slave/test', 11:20:18 INFO - 'SHELL': '/bin/bash', 11:20:18 INFO - 'SHLVL': '1', 11:20:18 INFO - 'TERM': 'linux', 11:20:18 INFO - 'TMOUT': '86400', 11:20:18 INFO - 'USER': 'cltbld', 11:20:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:18 INFO - '_': '/tools/buildbot/bin/python'} 11:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 INFO - Downloading docopt-0.6.1.tar.gz 11:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:21 INFO - Running setup.py install for blobuploader 11:20:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:21 INFO - Running setup.py install for requests 11:20:22 INFO - Running setup.py install for docopt 11:20:22 INFO - Successfully installed blobuploader requests docopt 11:20:22 INFO - Cleaning up... 11:20:22 INFO - Return code: 0 11:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:22 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:22 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 11:20:22 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 11:20:22 INFO - Using env: {'DISPLAY': ':0', 11:20:22 INFO - 'HOME': '/home/cltbld', 11:20:22 INFO - 'LANG': 'en_US.UTF-8', 11:20:22 INFO - 'LANGUAGE': 'en_US:en', 11:20:22 INFO - 'LOGNAME': 'cltbld', 11:20:22 INFO - 'MAIL': '/var/mail/cltbld', 11:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:22 INFO - 'MOZ_NO_REMOTE': '1', 11:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:22 INFO - 'NO_EM_RESTART': '1', 11:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:22 INFO - 'PWD': '/builds/slave/test', 11:20:22 INFO - 'SHELL': '/bin/bash', 11:20:22 INFO - 'SHLVL': '1', 11:20:22 INFO - 'TERM': 'linux', 11:20:22 INFO - 'TMOUT': '86400', 11:20:22 INFO - 'USER': 'cltbld', 11:20:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:22 INFO - '_': '/tools/buildbot/bin/python'} 11:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:22 INFO - Running setup.py (path:/tmp/pip-KBSoXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:22 INFO - Running setup.py (path:/tmp/pip-D8qMvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:22 INFO - Running setup.py (path:/tmp/pip-_tEs5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:22 INFO - Running setup.py (path:/tmp/pip-0OZ0o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:22 INFO - Running setup.py (path:/tmp/pip-svTQcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:22 INFO - Running setup.py (path:/tmp/pip-Bbm7pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:23 INFO - Running setup.py (path:/tmp/pip-ABLOmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:23 INFO - Running setup.py (path:/tmp/pip-ghMrUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:23 INFO - Running setup.py (path:/tmp/pip-xyLnyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:23 INFO - Running setup.py (path:/tmp/pip-fKtRGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:23 INFO - Running setup.py (path:/tmp/pip-fmVatI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:23 INFO - Running setup.py (path:/tmp/pip-V0HbbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:23 INFO - Running setup.py (path:/tmp/pip-U7R6B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:23 INFO - Running setup.py (path:/tmp/pip-e3eD6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:23 INFO - Running setup.py (path:/tmp/pip-VNw5cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:23 INFO - Running setup.py (path:/tmp/pip-PzrzL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:23 INFO - Running setup.py (path:/tmp/pip-6kgS5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:23 INFO - Running setup.py install for manifestparser 11:20:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:23 INFO - Running setup.py install for mozcrash 11:20:24 INFO - Running setup.py install for mozdebug 11:20:24 INFO - Running setup.py install for mozdevice 11:20:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for mozfile 11:20:24 INFO - Running setup.py install for mozhttpd 11:20:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for mozinfo 11:20:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for mozInstall 11:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for mozleak 11:20:24 INFO - Running setup.py install for mozlog 11:20:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for moznetwork 11:20:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:24 INFO - Running setup.py install for mozprocess 11:20:25 INFO - Running setup.py install for mozprofile 11:20:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:25 INFO - Running setup.py install for mozrunner 11:20:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:25 INFO - Running setup.py install for mozscreenshot 11:20:25 INFO - Running setup.py install for moztest 11:20:25 INFO - Running setup.py install for mozversion 11:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:25 INFO - Cleaning up... 11:20:25 INFO - Return code: 0 11:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:25 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:25 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 11:20:25 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 11:20:25 INFO - Using env: {'DISPLAY': ':0', 11:20:25 INFO - 'HOME': '/home/cltbld', 11:20:25 INFO - 'LANG': 'en_US.UTF-8', 11:20:25 INFO - 'LANGUAGE': 'en_US:en', 11:20:25 INFO - 'LOGNAME': 'cltbld', 11:20:25 INFO - 'MAIL': '/var/mail/cltbld', 11:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:25 INFO - 'MOZ_NO_REMOTE': '1', 11:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:25 INFO - 'NO_EM_RESTART': '1', 11:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:25 INFO - 'PWD': '/builds/slave/test', 11:20:25 INFO - 'SHELL': '/bin/bash', 11:20:25 INFO - 'SHLVL': '1', 11:20:25 INFO - 'TERM': 'linux', 11:20:25 INFO - 'TMOUT': '86400', 11:20:25 INFO - 'USER': 'cltbld', 11:20:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:25 INFO - '_': '/tools/buildbot/bin/python'} 11:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:25 INFO - Running setup.py (path:/tmp/pip-cpppgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:25 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)) 11:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:25 INFO - Running setup.py (path:/tmp/pip-BGt2oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:25 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)) 11:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:25 INFO - Running setup.py (path:/tmp/pip-yZQtI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:26 INFO - Running setup.py (path:/tmp/pip-6aC1p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:26 INFO - Running setup.py (path:/tmp/pip-G3s5kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:26 INFO - Running setup.py (path:/tmp/pip-eIGUl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:26 INFO - Running setup.py (path:/tmp/pip-981431-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:26 INFO - Running setup.py (path:/tmp/pip-DvilPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:26 INFO - Running setup.py (path:/tmp/pip-dUtTLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:26 INFO - Running setup.py (path:/tmp/pip-dvkgQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:26 INFO - Running setup.py (path:/tmp/pip-ANEEmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:26 INFO - Running setup.py (path:/tmp/pip-LYfAIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:26 INFO - Running setup.py (path:/tmp/pip-aLAbH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:26 INFO - Running setup.py (path:/tmp/pip-Zhgtye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:26 INFO - Running setup.py (path:/tmp/pip-nvonTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:26 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)) 11:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:26 INFO - Running setup.py (path:/tmp/pip-eJqBif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:27 INFO - Running setup.py (path:/tmp/pip-wQegwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:27 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)) 11:20:27 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)) 11:20:27 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)) 11:20:27 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)) 11:20:27 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)) 11:20:27 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)) 11:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:29 INFO - Downloading blessings-1.6.tar.gz 11:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:29 INFO - Installing collected packages: blessings 11:20:29 INFO - Running setup.py install for blessings 11:20:29 INFO - Successfully installed blessings 11:20:29 INFO - Cleaning up... 11:20:29 INFO - Return code: 0 11:20:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:29 INFO - Reading from file tmpfile_stdout 11:20:29 INFO - Current package versions: 11:20:29 INFO - argparse == 1.2.1 11:20:29 INFO - blessings == 1.6 11:20:29 INFO - blobuploader == 1.2.4 11:20:29 INFO - docopt == 0.6.1 11:20:29 INFO - functools32 == 3.2.3-2 11:20:29 INFO - jsonschema == 2.5.1 11:20:29 INFO - manifestparser == 1.1 11:20:29 INFO - mozInstall == 1.12 11:20:29 INFO - mozcrash == 1.0 11:20:29 INFO - mozdebug == 0.1 11:20:29 INFO - mozdevice == 0.49 11:20:29 INFO - mozfile == 1.2 11:20:29 INFO - mozhttpd == 0.7 11:20:29 INFO - mozinfo == 0.9 11:20:29 INFO - mozleak == 0.1 11:20:29 INFO - mozlog == 3.4 11:20:29 INFO - moznetwork == 0.27 11:20:29 INFO - mozprocess == 0.24 11:20:29 INFO - mozprofile == 0.28 11:20:29 INFO - mozrunner == 6.13 11:20:29 INFO - mozscreenshot == 0.1 11:20:29 INFO - mozsystemmonitor == 0.3 11:20:29 INFO - moztest == 0.8 11:20:29 INFO - mozversion == 1.4 11:20:29 INFO - psutil == 3.1.1 11:20:29 INFO - requests == 1.2.3 11:20:29 INFO - wsgiref == 0.1.2 11:20:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:29 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')]} 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 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')]} 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:29 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 11:20:29 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 11:20:29 INFO - Using env: {'DISPLAY': ':0', 11:20:29 INFO - 'HOME': '/home/cltbld', 11:20:29 INFO - 'LANG': 'en_US.UTF-8', 11:20:29 INFO - 'LANGUAGE': 'en_US:en', 11:20:29 INFO - 'LOGNAME': 'cltbld', 11:20:29 INFO - 'MAIL': '/var/mail/cltbld', 11:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:29 INFO - 'MOZ_NO_REMOTE': '1', 11:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:29 INFO - 'NO_EM_RESTART': '1', 11:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:29 INFO - 'PWD': '/builds/slave/test', 11:20:29 INFO - 'SHELL': '/bin/bash', 11:20:29 INFO - 'SHLVL': '1', 11:20:29 INFO - 'TERM': 'linux', 11:20:29 INFO - 'TMOUT': '86400', 11:20:29 INFO - 'USER': 'cltbld', 11:20:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:29 INFO - '_': '/tools/buildbot/bin/python'} 11:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 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)) 11:20:29 INFO - Cleaning up... 11:20:29 INFO - Return code: 0 11:20:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:29 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')]} 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 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')]} 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:30 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 0x15561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', '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 11:20:30 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 11:20:30 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 11:20:30 INFO - Using env: {'DISPLAY': ':0', 11:20:30 INFO - 'HOME': '/home/cltbld', 11:20:30 INFO - 'LANG': 'en_US.UTF-8', 11:20:30 INFO - 'LANGUAGE': 'en_US:en', 11:20:30 INFO - 'LOGNAME': 'cltbld', 11:20:30 INFO - 'MAIL': '/var/mail/cltbld', 11:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:30 INFO - 'MOZ_NO_REMOTE': '1', 11:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:30 INFO - 'NO_EM_RESTART': '1', 11:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:30 INFO - 'PWD': '/builds/slave/test', 11:20:30 INFO - 'SHELL': '/bin/bash', 11:20:30 INFO - 'SHLVL': '1', 11:20:30 INFO - 'TERM': 'linux', 11:20:30 INFO - 'TMOUT': '86400', 11:20:30 INFO - 'USER': 'cltbld', 11:20:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:30 INFO - '_': '/tools/buildbot/bin/python'} 11:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:20:30 INFO - Cleaning up... 11:20:30 INFO - Return code: 0 11:20:30 INFO - Running post-action listener: _resource_record_post_action 11:20:30 INFO - Running post-action listener: _start_resource_monitoring 11:20:30 INFO - Starting resource monitoring. 11:20:30 INFO - [mozharness: 2017-01-10 19:20:30.265547Z] Finished create-virtualenv step (success) 11:20:30 INFO - [mozharness: 2017-01-10 19:20:30.266045Z] Running install step. 11:20:30 INFO - Running pre-action listener: _resource_record_pre_action 11:20:30 INFO - Running main action method: install 11:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:30 INFO - Reading from file tmpfile_stdout 11:20:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:30 INFO - Reading from file tmpfile_stdout 11:20:30 INFO - Output received: 11:20:30 INFO - Usage: mozinstall [options] installer 11:20:30 INFO - Options: 11:20:30 INFO - -h, --help show this help message and exit 11:20:30 INFO - -d DEST, --destination=DEST 11:20:30 INFO - Directory to install application into. [default: 11:20:30 INFO - "/builds/slave/test"] 11:20:30 INFO - --app=APP Application being installed. [default: firefox] 11:20:30 INFO - mkdir: /builds/slave/test/build/application 11:20:30 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'] 11:20:30 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 11:20:47 INFO - Reading from file tmpfile_stdout 11:20:47 INFO - Output received: 11:20:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:20:47 INFO - Running post-action listener: _resource_record_post_action 11:20:47 INFO - [mozharness: 2017-01-10 19:20:47.948713Z] Finished install step (success) 11:20:47 INFO - [mozharness: 2017-01-10 19:20:47.949045Z] Running run-tests step. 11:20:47 INFO - Running pre-action listener: _resource_record_pre_action 11:20:47 INFO - Running main action method: run_tests 11:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:47 INFO - Python 2.7.3 11:20:47 INFO - Return code: 0 11:20:47 INFO - grabbing minidump binary from tooltool 11:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:47 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 0x18c5820>, '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 0x18c6520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c69b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:47 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 11:20:47 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 11:20:47 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 11:20:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:48 INFO - Return code: 0 11:20:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:20:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:20:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:48 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:20:48 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 11:20:48 INFO - Using env: {'DISPLAY': ':0', 11:20:48 INFO - 'HOME': '/home/cltbld', 11:20:48 INFO - 'LANG': 'en_US.UTF-8', 11:20:48 INFO - 'LANGUAGE': 'en_US:en', 11:20:48 INFO - 'LOGNAME': 'cltbld', 11:20:48 INFO - 'MAIL': '/var/mail/cltbld', 11:20:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:48 INFO - 'MOZ_NO_REMOTE': '1', 11:20:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:48 INFO - 'NO_EM_RESTART': '1', 11:20:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:48 INFO - 'PWD': '/builds/slave/test', 11:20:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:48 INFO - 'SHELL': '/bin/bash', 11:20:48 INFO - 'SHLVL': '1', 11:20:48 INFO - 'TERM': 'linux', 11:20:48 INFO - 'TMOUT': '86400', 11:20:48 INFO - 'USER': 'cltbld', 11:20:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175', 11:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:48 INFO - '_': '/tools/buildbot/bin/python'} 11:20:48 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/1484069787/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:20:48 INFO - mozversion application_buildid: 20170110093627 11:20:48 INFO - mozversion application_changeset: 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 11:20:48 INFO - mozversion application_display_name: Nightly 11:20:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:48 INFO - mozversion application_name: Firefox 11:20:48 INFO - mozversion application_remotingname: firefox 11:20:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:20:48 INFO - mozversion application_vendor: Mozilla 11:20:48 INFO - mozversion application_version: 53.0a1 11:20:48 INFO - mozversion platform_buildid: 20170110093627 11:20:48 INFO - mozversion platform_changeset: 36e0e97d1c1b11b9f928fd5a7b38b9d084ba7676 11:20:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:20:48 INFO - mozversion platform_version: 53.0a1 11:20:48 INFO - using testdate: 1484076048 11:20:48 INFO - actual date: 1484076048 11:20:48 INFO - starting webserver on 'localhost:41764' 11:20:48 INFO - SUITE-START | Running 2 tests 11:20:48 INFO - TEST-START | dromaeo_css 11:20:48 INFO - operating with platform_type : linux_ 11:20:48 INFO - Initialising browser for dromaeo_css test... 11:20:48 INFO - TEST-INFO | started process 8205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV6_bh_/profile http://localhost:41764/getInfo.html) 11:20:52 INFO - PROCESS | 8205 | __metrics Screen width/height:1600/1200 11:20:52 INFO - PROCESS | 8205 | colorDepth:24 11:20:52 INFO - PROCESS | 8205 | Browser inner width/height: 1024/697 11:20:52 INFO - PROCESS | 8205 | __metrics 11:20:52 ERROR - PROCESS | 8205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 11:20:53 INFO - TEST-INFO | 8205: exit 0 11:20:53 INFO - Browser initialized. 11:20:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:20:53 INFO - TEST-INFO | started process 8326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV6_bh_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:05 INFO - PROCESS | 8326 | RSS: Main: 155828224 11:21:05 INFO - PROCESS | 8326 | 11:24:06 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41764/tests/dromaeo/cssquery-ext.html) 11:24:07 INFO - PROCESS | 8326 | RSS: Main: 163917824 11:24:07 INFO - PROCESS | 8326 | 11:25:54 INFO - PROCESS | 8326 | ************************* 11:25:54 INFO - PROCESS | 8326 | A coding exception was thrown and uncaught in a Task. 11:25:54 INFO - PROCESS | 8326 | 11:25:54 INFO - PROCESS | 8326 | Full message: ReferenceError: fetch is not defined 11:25:54 INFO - PROCESS | 8326 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:25:54 INFO - PROCESS | 8326 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:25:54 INFO - PROCESS | 8326 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:25:54 INFO - PROCESS | 8326 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:25:54 INFO - PROCESS | 8326 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:25:54 INFO - PROCESS | 8326 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:25:54 INFO - PROCESS | 8326 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:25:54 INFO - PROCESS | 8326 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:25:54 INFO - PROCESS | 8326 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:25:54 INFO - PROCESS | 8326 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:25:54 INFO - PROCESS | 8326 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:25:54 INFO - PROCESS | 8326 | 11:25:54 INFO - PROCESS | 8326 | ************************* 11:27:09 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-ext.html (next: http://localhost:41764/tests/dromaeo/cssquery-jquery.html) 11:27:10 INFO - PROCESS | 8326 | RSS: Main: 160219136 11:27:10 INFO - PROCESS | 8326 | 11:30:12 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41764/tests/dromaeo/cssquery-mootools.html) 11:30:12 INFO - PROCESS | 8326 | RSS: Main: 165715968 11:30:12 INFO - PROCESS | 8326 | 11:33:14 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41764/tests/dromaeo/cssquery-prototype.html) 11:33:15 INFO - PROCESS | 8326 | RSS: Main: 161271808 11:33:15 INFO - PROCESS | 8326 | 11:36:17 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41764/tests/dromaeo/cssquery-yui.html) 11:36:18 INFO - PROCESS | 8326 | RSS: Main: 164982784 11:36:18 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | Cycle 1(1): loaded http://localhost:41764/tests/dromaeo/cssquery-yui.html (next: http://localhost:41764/tests/dromaeo/cssquery-dojo.html) 11:39:21 INFO - PROCESS | 8326 | RSS: Main: 164909056 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | __start_tp_report 11:39:21 INFO - PROCESS | 8326 | _x_x_mozilla_page_load 11:39:21 INFO - PROCESS | 8326 | _x_x_mozilla_page_load_details 11:39:21 INFO - PROCESS | 8326 | |i|pagename|runs| 11:39:21 INFO - PROCESS | 8326 | |0;dojo.html;3173.143251322143;3182.9363412731745;3211.9036428907143;3211.9518207226897;3212.903612891613;5261;5374.7043912584795;5377.569794416447;5403.0274550580925;5418.647787893789;5285.814996475124;5422.75597598108;5478.890422191554;5501.4223506531835;5570.3315602127805;4833.75831208439;4839.9274010889685;4887.218045112782;4942.332785074005;4997.350344455234;4786.760661966905;4889.877753056185;4960.280759289901;4964.925526117111;4977.55202031817;4764.928526072112;4911.238757992517;4947.529984651488;4954.5540901319055;4973.825916092937;4808.543188397131;4839.709617422931;4863;4895.902081958377;4973.7513124344;4878.365812444395;4885.2916327132725;4887;4910;4916.901661966741;5419.376771671269;5433.782648694048;5435.266239057716;5448.237246785453;5480.698561579112;5660;5702.059160238556;5721.599488035839;5743.741531631086;5747.971260143672;5825.854353641193;5830.242068531106;5834.5624078194305;5838.620489668158;5883.794067207627;5441.646292990982;5443.237946687467;5446.754896029688;5450.964316779799;5451.48210919962;5785.88428231433;5835.56233282497;5879;5907.793227237026;5945;5715.085586306171;5726.3700992890745;5735.225744524436;5784.4504772046585;5788.247527821356;5767.22142510764;5778.711064446761;5808.564357673192;5821.359650438449;5844.649321040752;5657.915131273035;5694.088945768657;5699.344575373802;5779.190913272145;5782.219400380979;5755.165501002331;5766.5675074368755;5774.2782152230975;5780.335261444988;5815;4492.303692927601;4529.297958816389;4534.161180181677;4556.977215113903;4580.541945805459;4051.088505086391;4053.115995225746;4055.918881622351;4065.1869626074904;4093.099518106012;5314.2825718528275;5328.520433161034;5474.945250547523;5503.807366742145;5597.860053498695;5869.970650146722;5872.324682661463;5872.7357268923;5880.117982302689;5902.026165682614;5503.834884953458;5522.171674248895;5551.417101204315;5552;5554.250176226158;4819.518048195152;4897.2654101885;4947.35684361038;5036.84889453317;5075.416327122354;5946.167536544887;6065.211522502046;6076.635401875901;6105.877882442326;6120.510359171256;5851.1515830205235;5865.384134665798;5866.970665146647;5872.853178670396;5877.676727779842;5861.648301101947;6071.939280607314;6076.544259180668;6087.299960504599;6089.238845144357;5580.86047848807;5706.885862282648;5712.428757124254;5749.9712501437225;5779.653220806765;5797.9420205797405;5803.65178089316;5868.09044598088;5869.618474799125;5870.119482077723;5670.829875103754;5682.090865461506;5708.286464191976;5716.085426331767;5718.628289161191;5483.7806487740045;5516.034693928626;5663.065594176915;5675.8864822704145;5702.971485142548;5699.629524080921;5731.856703582277;5734.770609175586;5753.539716822561;5775.48020678141;5594.188842617879;5642.520385767256;5740.483356497935;5789.45000224978;5794.159846822272;5514.944850551604;5544.7227638618715;5558.694271814928;5632.239647647515;5682.516986056232 11:39:21 INFO - PROCESS | 8326 | |1;ext.html;566.382642919218;572.86537663649;573.7246121861504;578.1299144787096;603.1013789453715;42208;45018;45256.3211551827;49274.75362623182;49511.50488495114;45609;46013;46022.53977460224;46080.308795368015;46147.307790383085;9104.908950910472;9284.350095493319;9287.11772381626;9313.208377287938;10424.63513777018;10211.33626314291;10550.630727924525;10592.15262778976;10593.523291451904;10603.098736607397;10619.46902654868;10655.84016239757;10669.306495077795;10683.893161068407;10688.251822372436;10529.420881851494;10530.894691053069;10580.418077005761;10606.310589811676;10632.893671063268;10287.845682314772;10413.427261500614;10481.109105726022;10517.158627309796;10520.631777887813;39804.601953980666;40142.397864032064;40157.598424015676;40293.79853100716;40512.594874051174;4125.958740412588;4162.666986641092;4229.767362795045;4230.7038507304505;4250.872473825791;28721.569176462162;29270.268243293875;29680;29739;30811.075667730005;4251.2347777400055;4304.461942257218;4347.130573885204;4352.978235108836;4414.183376075436;336909;338921;339587;341181;341279;54013;54319.18521222185;54333;54396.45603543993;54566.72716636391;56586;57090;57160.71419642875;57164;57278.7136064317;13508.729825403438;13646.385912633956;13819.585412437644;13823.79264311036;13844.377003034888;11276.1542884284;11360.602378916697;11390.202685812079;11402.486888090056;11828.76342473163;18127.456176314732;18263.54341141482;18289.451316460527;18342.90828545849;18347.63304733898;7339.633018349061;7358.889616655754;7553.244675532403;7563.9621801890635;7589.392848572101;950.3442624589012;969.5685419988038;973.2846357926918;974.0357046523891;974.4591751577942;30939.535906961413;31751.68248317487;31910.840445798087;32079.35841283208;32240.516392254136;1054.5939813171983;1137.7383201863618;1154.1574650505179;1181.1613754234418;1187.7861984842812;16336.836631633769;16943.83056169447;17233.827661723473;17412.738808917875;17507.212175452136;536017;539988;540534;542881;542898;64367.356326437075;64895;65054.67472662701;65056;65152.67423662851;1476.0258229568649;1476.9852301477063;1481.4222453243244;1509.7881603450996;1510.4335874047233;30486.695133048386;30956.845215773777;31324.530132048494;31344.68655313509;32563.674363256065;53147.73426132999;54431.45568544264;54574.18138728002;54672;54687.45312546983;332884;335460;335728;336349;337594;28684.139475814925;46824.7658761704;47430;48313;50285.49714502808;48173.27740083972;48267.75866120647;49139.75430122826;52662.210066849795;53070.46929530655;42192.15615687607;44356;44426.77786611046;45137.32294015527;46134;43156.56843431525;43811.780941095094;44360.55639443564;45057;45497.545024549334;44264.7786761077;44634.3304850421;44653.10693786041;44825.55174448344;47085;34848.30303393969;39099.413508796824;39276;40544.594554054085;40713;29687.85156074206;29796.255093622833;30001.69998299989;30410.239744005692;30557.54163687502 11:39:21 INFO - PROCESS | 8326 | |2;jquery.html;405.2341075367554;416.31723972684784;426.3093788063337;429.90756987247744;448.8182286174099;19236.615267694637;20635.484112897186;21138.260160894373;21713.565728685455;22105;20819.895900520478;21276.89361553194;22123.225687100956;22384.88807555964;22404.43988900274;5385.623006389555;5675.460831221028;5676.063449530822;5679.744411501471;5697.259356283677;5411.053065713504;5541.473560011793;5592.748326325325;5597.916031259534;5600.075987462084;5547.8890422191735;5549.084401073818;5577.69322687252;5579.358373787006;5601.495865372116;5363.383210930734;5461.2354270402175;5466.316710411199;5484.588655850807;5505.834824955257;5225.634205605609;5353.223782551547;5374.113271310229;5377.865553361197;5385.838424847261;25410.36474088144;25705.35736606581;25725.614115788278;26028.609570856454;26096;2635.934101647455;2648.4041090754617;2750.4911591355462;3125.6718044605445;3158.368326334742;10917;11026.558937642485;11035.889641103566;11042.944785276022;11539.884601154048;1995.9700604490945;2022.393282015404;2024.767151777535;2032.3598066609118;2036.2160568181357;92445.07554924431;93016.53491732565;93623.53188234083;96190;100626;12053.26348831865;12309;12431.689207769698;12453.501859925682;12541;17351.39270125565;17450.56373590645;17521.912390437967;17537.824621753873;17607.823921760617;7975.60121993898;8095.919040809635;8158.755237342889;8215.835683286301;8307.210814972568;7324.670389832364;7366.558006519626;7444.106707195063;7565.583892885834;7608.201138880338;5161.896762064737;5223.112070947948;5242.344706911636;5243.9213411798855;5331.20031995196;2088.937331880046;2120.204923153817;2163.459135216196;2215.977840221577;2242.596332660104;972.5331840716495;972.6401231544373;985.265976847239;986.8569057486624;1001.979960400788;19949.60100797976;20287.4928126798;20297.49256268605;20934.37196884096;22618;991.5934466868694;994.3735446668552;1016.8220561401873;1018.8267994440963;1024.830902901013;10524.947375263075;11204.383758893338;11232.269902456314;11305.604303849326;11360.431978401048;642332;652242;663405;673571;674632.7903930563;93465;93703;110437.44781276042;110730;111174;1066.7279843639822;1112.7273817914663;1125.606037886733;1132.7369982469652;1138.1577632551853;17734.73397899007;17769.378071767427;17846.732299015785;18137.183826728095;18343.26626934908;46309;46555.767221163675;46850.53149468462;47786;48327.32707216005;57088.42911570831;57915;58737.706311468166;64592.677036614514;68058.65970670115;7722.92277077222;8488.236058754741;9011.23404510624;9235.861462077939;9251.444913305224;13814.378352974341;14659.706805864036;14742.852571474577;14784.408623654934;14860.256987150815;11906.166568340133;12154.696132596402;12208.69478263015;12282.631521054383;12504.937475312565;11719.238249514096;11957.701057473285;12077.818832717692;12107.273563586214;12295.754084918073;12390.442430090487;12525.373731313215;12653.177543459646;12919.935400322938;13237.470501179845;9169.174774270348;9356.906430935876;9371.34400591952;9558.522073896416;9699.078587534173;9338.533073346442;12098;12625.558105466265;12667.619971400873;12748.362581870684 11:39:21 INFO - PROCESS | 8326 | |3;mootools.html;1450.9347079381428;1472.5950363650002;1487.7024595080984;1492.2240434973814;1518.1650092449154;7660.540367577935;7853;8112.391570632197;8550.102239264874;8555.443896146753;8219.71231006915;8520.829583408344;8571.142885711426;8741.431806932545;8754.824903501925;2292.518571100071;2338.5089131282452;2341.250799744074;2342.894569744357;2346.9178578749747;2317.409060689522;2354.788069073783;2360.881955902198;2377.0491803278655;2377.41753270449;2311.0986715181007;2317.0268487235317;2328.231683544435;2350.8119350452007;2351.905923763047;2263.4907145892207;2282.805961493275;2285.8399912006166;2292.151903795598;2292.7363353214428;2293.1629955066446;2296.2996286132725;2310.364649721323;2322.7096612923383;2328.953420931572;8526.190011948855;8570.27152692022;8572.82854342916;8609.440386374865;8642.870356944652;5152.124138896396;5200.713960732158;5260.579153667697;5276.736163191825;5291.100512912814;3095.31902981346;3141.8900338488043;3343.0806528204694;3343.749218808575;3347.062822409729;1308.319673769644;1317.0780453682364;1330.3880215101065;1365.242290528756;1396.7093965895938;11615.303081815118;11651.94174029133;11658.591949281734;11666.475008624633;11671.533138674527;4280.76455794928;4437.245668236407;4477.507474177838;4511.05267893746;4577.748223847654;9858.753531161636;9912.454814985102;9920.652777152909;9985.850212246822;9989.450580218012;5155.690658560498;5222.608304377187;5223.216517522402;5226.634135610547;5232.659877107976;4687.906241875144;4843.24929635907;4866.7079975201605;4903.754812259373;4952.232403977389;3604.459331100356;3657.104009517685;3715.3498137825773;3750.774953502799;3770.170562476306;1085.3325204998869;1092.8852470490642;1093.2128867215592;1093.9015488606065;1117.5529788084832;932.5104320231933;947.8104379124203;951.509972364233;953.5280036382036;955.3599088610648;5691.544676425876;5726.484616384545;5759.884802303931;5950.434708702666;5980.192673988956;625.0031200235617;630.168178005029;633.4583930739244;636.1507387637556;638.250056183982;3980.8208630611693;4082.2039702258367;4100.384942258685;4145.150244199932;4182.581741825793;10055.849162262572;10319.226058045677;10357;10396.48017599117;10410.635627752992;10113.747156321151;10207.693769186937;10232.283740138118;10236.078752912124;10281.280310378203;8001.901912809226;8029.317508011768;8039.196080392031;8085.110637829834;8109.351251899834;5767.711614419179;5780.9883270428345;5790.507806836466;5799.884002320015;5896.764129434775;9260.53697315118;9292.860607091034;9365.672201472917;9396.01341859095;9449.43303401798;9077.500737459502;9373.20327772147;9417.058294170529;9580.904190958001;9655.372400793925;6939.618320992192;7128.215896251305;7210.062691850026;7558.546487210785;7575.24247575238;8036.95981520112;8385;8386.832263354821;8389.244967952913;8414;7365.7790266292095;7365.7790266292095;7383.8154046149275;7489.251074892467;7767.339776118867;7283.927160728324;7335.4498412618195;7386.556806591621;7407.333339999426;7434.59109748969;6550.115734375989;6705.1283333166375;6709.7316107355155;6741.292164322872;6746.089277947414;4923.926141107814;4927.187014142626;4971.279164521196;5021.815510253052;5143.562797162133;4943.159662857251;4969.105560999054;5042.848714538423;5064.139096353555;5080.644354895269 11:39:21 INFO - PROCESS | 8326 | |4;prototype.html;391.69839223797675;407.19172442701233;413.755884028423;415.8357448807719;417.3822742341335;5270.9458108378285;5417.83746487605;5531.22562841202;5604.497189256715;5612.69130197839;5326.893462130764;5391.946080539194;5400.648957817739;5422.674639521621;5445.482679145475;4276.87169384919;4289.742615443083;4295.677824163185;4303.440552728141;4322.017807712668;4026.8590599329027;4206.768627725474;4320.222359975203;4342.891427714317;4350.847025538234;4159.771212583307;4176.18564379946;4194.769287689176;4199.971007103264;4201.285781417151;4205.621494065534;4224.429701990222;4237.915241695179;4240.5759424057505;4264;3789.5263092113487;3795.3737633290475;3801.3917773156163;3804.6766024887916;3808.5620153682403;5253.658512196695;5335.386430560497;5349.689326115126;5356.54469370104;5379.139337705988;4921.335619691367;4962.478939711351;4962.578180854632;4987.47631498691;5006.5494105530315;5457.426970168154;5629.690367029812;5753.252077229975;5821.7380217890295;5823.67969761663;4135.441715368417;4147.04617937876;4148.2947898857265;4154.875353739392;4167.333226683716;5980.641161530322;6000.689734452224;6006.489448396892;6046.2744470663365;6065.302490213638;4038.4548086008012;4283.528811830696;4317.84887528935;4322.524522302544;4331.891702707395;4293.656507479394;4328.372386004012;4335.3713711511655;4349.391085248068;4364.345348197796;4836.951630483721;4893.412790465096;4908.4846091160625;4933.371987244201;4982.850514484571;5516.751746171351;5850.151727999416;5859.560532960045;5874.618149820248;5874.735636896265;1440.488626537585;1455.5415044261024;1457.6137323609253;1458.7884756710218;1460.6202387379146;979.911807937289;1004.7287232447198;1014.4521958142668;1023.65195833417;1028.9125424339015;5367.812126575629;5383.569314454834;5389.568834493231;5467.644603100785;5495.203195536625;5787.768489260467;5816.709164541756;5862.237909071879;5864;5893.233879595625;5270.021134043849;5424.593155513352;5441.564674826004;5535.197396377503;5620.49415552594;3045.4974929136442;3046.8019578727312;3060.56153607804;3069.4628440022907;3083.182956516525;5755.22304488897;6010.729517171738;6013.849653758691;6017.849553761103;6039.486643635252;5806.938536819368;5851.941480585225;5853.990016838479;5854.385289544622;5890.263717035371;5974.312954010171;5990.700464976734;6004.129401236796;6013.579049466583;6028.487578555784;5587.7485513152815;5675.829725108253;5694.544436444991;5694.743736531783;5762.164486149569;5587.972060139673;5649.435056494318;5691.288588926384;5711.143328500758;5760.963026655075;5788.768449261982;6018.668973206516;6042.546808989431;6053.424924632153;6063.423974722395;4411.514733379261;4449.51055383914;4518.514816850653;4546.704464209815;4555.703879247838;5906.304487932191;5916.437938395846;5920.79277225295;5938.841925824423;5949.2266005419015;5570.24801651788;5752.482276594959;5783.479486846204;5794.594378393472;5827.446392592697;5705.4009329019855;5730.426957304237;5745.224394706661;5765.164051212634;5767.971160144172;5765.068701984882;5770.076787713946;5773.24947756789;5798.304203495439;5820.854478638068;5521.420250873601;5747.1379293106365;5748.425157484218;5791.7683292667825;5795.33353664334;5648.858778530405;5674.9853801899735;5693.9430605693415;5720.255322126792;5730.799422020209 11:39:21 INFO - PROCESS | 8326 | |5;yui.html;698.6329159018156;736.3299397548233;771.0785611194622;809.6680361051968;813.8575749243881;15879.603009924744;16726;16788.916055419722;16816.663666726672;16865.40971066013;15545.06729596225;15773.921130394332;15773.921130394361;15781.447649332276;15800.130992795392;643.3084434233194;659.5284371674252;736.0688728758125;744.5197847388445;755.9017327747385;774.9380049596019;776.8252143267777;777.0869228656335;777.3897490469982;778.1557010643459;803.6584451608072;804.2600807257309;811.0470197517923;811.6550466051934;813.6501304439089;803.4937989066909;803.8995125609329;804.6379129391768;804.8028233082873;806.0730160315625;593.7654626422539;594.696704680616;594.9048152295655;596.4333882811303;598.1356939222825;15872.682546349124;15907.92046039774;16013;16142.838571614251;16508.33966641333;13886.305684715824;14581.562553123424;14634.560963171121;14643.56069317922;14700.191489468076;11865.169438139334;11907.16649834512;11912.702182445422;11930.940345298304;11937.94031029848;3653.104989277644;3696.9630303696886;3728.086618778417;3739.981300093509;3856.730028897978;75740.24259757443;76062.23937760606;76944.23055769426;78074.60962695206;78881.60559197282;10262.743431414274;10418.11446027081;10439.321444106108;10492.055714985536;11505.194636375541;21676.24133155332;21998.89000554987;22052.669209961863;23389.41526461818;23627.881860590587;8166.836663266701;8220.958895205606;8257.133001034925;8316.542590157478;8394.24451799341;4403.911921761611;4420.889477763081;4538.909221815546;4545.36364908913;4584.747838868828;3708.49935258742;3758.079270578671;3758.962410375916;3771.132639492877;3815.313243616176;608.2700759089022;613.5214532664529;614.0359635372512;629.2103410220236;631.0660222870177;728.4027097779875;738.2580506590842;747.3236720767713;755.5844285642875;773.9226077392216;10306.278560500694;10432.947835260775;10611.151107911348;10728.371548970552;10947.56209751617;818.5088946631973;819.2631620963596;820.5527987246965;829.4691397505601;852.0754980845728;4785.856424307276;5118.539331460112;5177.767000484987;5224.973875130676;5242.501962313574;79460.20539794644;80744.59627701824;81001;81079.59460202779;81186.18813811787;57474;68311;68649.31350686529;68712.3128768716;69224.6538767303;51084.48915510871;58805.41194588085;59449.10826337608;59748.10377844336;60138.39861601416;10481.528331224961;10850.78298434011;10970.232083754061;10992.505337260003;11069.612563560237;41491;41769.79115104405;42281.154376911676;42629.93425164271;43770.34344484771;49415.50584494109;52133.47866521286;52159.73920130375;54281.457185427644;54479.18281225864;13377.063605547908;13384.799228011392;13442.596722098353;13627.931860340635;13689.931550342184;13827.170369777845;14075.859241407865;14563.126212427289;15327.923360383573;16621;13592.184468931895;13636.863631363956;13851.16892986424;14195.148291102567;15112.546623601309;14514.854851451773;14841.257937103317;15180.848191517944;15195.392184312504;15204.087754734752;13723.313834308045;13739.450421983009;13806;13957.58127256184;14763.630909227355;11077.279976801483;11274.267172633752;11556.59551915679;11616;11846.763064738829;11034.337939723322;11167.329960202414;11225.742938541216;11400.771984560097;11950.223235489666 11:39:21 INFO - PROCESS | 8326 | __end_tp_report 11:39:21 INFO - PROCESS | 8326 | __start_cc_report 11:39:21 INFO - PROCESS | 8326 | _x_x_mozilla_cycle_collect,319 11:39:21 INFO - PROCESS | 8326 | __end_cc_report 11:39:21 INFO - PROCESS | 8326 | __startTimestamp1484077161729__endTimestamp 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | ------- Summary: start ------- 11:39:21 INFO - PROCESS | 8326 | Number of tests: 6 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#0] dojo.html Cycles:165 Average:5399.00 Median:5632.24 stddev:603.95 (10.7%) stddev-sans-first:580.01 11:39:21 INFO - PROCESS | 8326 | Values: 3173.1 3182.9 3211.9 3212.0 3212.9 5261.0 5374.7 5377.6 5403.0 5418.6 5285.8 5422.8 5478.9 5501.4 5570.3 4833.8 4839.9 4887.2 4942.3 4997.4 4786.8 4889.9 4960.3 4964.9 4977.6 4764.9 4911.2 4947.5 4954.6 4973.8 4808.5 4839.7 4863.0 4895.9 4973.8 4878.4 4885.3 4887.0 4910.0 4916.9 5419.4 5433.8 5435.3 5448.2 5480.7 5660.0 5702.1 5721.6 5743.7 5748.0 5825.9 5830.2 5834.6 5838.6 5883.8 5441.6 5443.2 5446.8 5451.0 5451.5 5785.9 5835.6 5879.0 5907.8 5945.0 5715.1 5726.4 5735.2 5784.5 5788.2 5767.2 5778.7 5808.6 5821.4 5844.6 5657.9 5694.1 5699.3 5779.2 5782.2 5755.2 5766.6 5774.3 5780.3 5815.0 4492.3 4529.3 4534.2 4557.0 4580.5 4051.1 4053.1 4055.9 4065.2 4093.1 5314.3 5328.5 5474.9 5503.8 5597.9 5870.0 5872.3 5872.7 5880.1 5902.0 5503.8 5522.2 5551.4 5552.0 5554.3 4819.5 4897.3 4947.4 5036.8 5075.4 5946.2 6065.2 6076.6 6105.9 6120.5 5851.2 5865.4 5867.0 5872.9 5877.7 5861.6 6071.9 6076.5 6087.3 6089.2 5580.9 5706.9 5712.4 5750.0 5779.7 5797.9 5803.7 5868.1 5869.6 5870.1 5670.8 5682.1 5708.3 5716.1 5718.6 5483.8 5516.0 5663.1 5675.9 5703.0 5699.6 5731.9 5734.8 5753.5 5775.5 5594.2 5642.5 5740.5 5789.5 5794.2 5514.9 5544.7 5558.7 5632.2 5682.5 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#1] ext.html Cycles:180 Average:58369.31 Median:40628.80 stddev:110111.38 (271.0%) stddev-sans-first:110334.74 11:39:21 INFO - PROCESS | 8326 | Values: 566.4 572.9 573.7 578.1 603.1 42208.0 45018.0 45256.3 49274.8 49511.5 45609.0 46013.0 46022.5 46080.3 46147.3 9104.9 9284.4 9287.1 9313.2 10424.6 10211.3 10550.6 10592.2 10593.5 10603.1 10619.5 10655.8 10669.3 10683.9 10688.3 10529.4 10530.9 10580.4 10606.3 10632.9 10287.8 10413.4 10481.1 10517.2 10520.6 39804.6 40142.4 40157.6 40293.8 40512.6 4126.0 4162.7 4229.8 4230.7 4250.9 28721.6 29270.3 29680.0 29739.0 30811.1 4251.2 4304.5 4347.1 4353.0 4414.2 336909.0 338921.0 339587.0 341181.0 341279.0 54013.0 54319.2 54333.0 54396.5 54566.7 56586.0 57090.0 57160.7 57164.0 57278.7 13508.7 13646.4 13819.6 13823.8 13844.4 11276.2 11360.6 11390.2 11402.5 11828.8 18127.5 18263.5 18289.5 18342.9 18347.6 7339.6 7358.9 7553.2 7564.0 7589.4 950.3 969.6 973.3 974.0 974.5 30939.5 31751.7 31910.8 32079.4 32240.5 1054.6 1137.7 1154.2 1181.2 1187.8 16336.8 16943.8 17233.8 17412.7 17507.2 536017.0 539988.0 540534.0 542881.0 542898.0 64367.4 64895.0 65054.7 65056.0 65152.7 1476.0 1477.0 1481.4 1509.8 1510.4 30486.7 30956.8 31324.5 31344.7 32563.7 53147.7 54431.5 54574.2 54672.0 54687.5 332884.0 335460.0 335728.0 336349.0 337594.0 28684.1 46824.8 47430.0 48313.0 50285.5 48173.3 48267.8 49139.8 52662.2 53070.5 42192.2 44356.0 44426.8 45137.3 46134.0 43156.6 43811.8 44360.6 45057.0 45497.5 44264.8 44634.3 44653.1 44825.6 47085.0 34848.3 39099.4 39276.0 40544.6 40713.0 29687.9 29796.3 30001.7 30410.2 30557.5 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#2] jquery.html Cycles:180 Average:35244.65 Median:26062.30 stddev:108693.15 (417.1%) stddev-sans-first:108966.58 11:39:21 INFO - PROCESS | 8326 | Values: 405.2 416.3 426.3 429.9 448.8 19236.6 20635.5 21138.3 21713.6 22105.0 20819.9 21276.9 22123.2 22384.9 22404.4 5385.6 5675.5 5676.1 5679.7 5697.3 5411.1 5541.5 5592.7 5597.9 5600.1 5547.9 5549.1 5577.7 5579.4 5601.5 5363.4 5461.2 5466.3 5484.6 5505.8 5225.6 5353.2 5374.1 5377.9 5385.8 25410.4 25705.4 25725.6 26028.6 26096.0 2635.9 2648.4 2750.5 3125.7 3158.4 10917.0 11026.6 11035.9 11042.9 11539.9 1996.0 2022.4 2024.8 2032.4 2036.2 92445.1 93016.5 93623.5 96190.0 100626.0 12053.3 12309.0 12431.7 12453.5 12541.0 17351.4 17450.6 17521.9 17537.8 17607.8 7975.6 8095.9 8158.8 8215.8 8307.2 7324.7 7366.6 7444.1 7565.6 7608.2 5161.9 5223.1 5242.3 5243.9 5331.2 2088.9 2120.2 2163.5 2216.0 2242.6 972.5 972.6 985.3 986.9 1002.0 19949.6 20287.5 20297.5 20934.4 22618.0 991.6 994.4 1016.8 1018.8 1024.8 10524.9 11204.4 11232.3 11305.6 11360.4 642332.0 652242.0 663405.0 673571.0 674632.8 93465.0 93703.0 110437.4 110730.0 111174.0 1066.7 1112.7 1125.6 1132.7 1138.2 17734.7 17769.4 17846.7 18137.2 18343.3 46309.0 46555.8 46850.5 47786.0 48327.3 57088.4 57915.0 58737.7 64592.7 68058.7 7722.9 8488.2 9011.2 9235.9 9251.4 13814.4 14659.7 14742.9 14784.4 14860.3 11906.2 12154.7 12208.7 12282.6 12504.9 11719.2 11957.7 12077.8 12107.3 12295.8 12390.4 12525.4 12653.2 12919.9 13237.5 9169.2 9356.9 9371.3 9558.5 9699.1 9338.5 12098.0 12625.6 12667.6 12748.4 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#3] mootools.html Cycles:180 Average:5581.71 Median:5153.91 stddev:3108.27 (60.3%) stddev-sans-first:3101.49 11:39:21 INFO - PROCESS | 8326 | Values: 1450.9 1472.6 1487.7 1492.2 1518.2 7660.5 7853.0 8112.4 8550.1 8555.4 8219.7 8520.8 8571.1 8741.4 8754.8 2292.5 2338.5 2341.3 2342.9 2346.9 2317.4 2354.8 2360.9 2377.0 2377.4 2311.1 2317.0 2328.2 2350.8 2351.9 2263.5 2282.8 2285.8 2292.2 2292.7 2293.2 2296.3 2310.4 2322.7 2329.0 8526.2 8570.3 8572.8 8609.4 8642.9 5152.1 5200.7 5260.6 5276.7 5291.1 3095.3 3141.9 3343.1 3343.7 3347.1 1308.3 1317.1 1330.4 1365.2 1396.7 11615.3 11651.9 11658.6 11666.5 11671.5 4280.8 4437.2 4477.5 4511.1 4577.7 9858.8 9912.5 9920.7 9985.9 9989.5 5155.7 5222.6 5223.2 5226.6 5232.7 4687.9 4843.2 4866.7 4903.8 4952.2 3604.5 3657.1 3715.3 3750.8 3770.2 1085.3 1092.9 1093.2 1093.9 1117.6 932.5 947.8 951.5 953.5 955.4 5691.5 5726.5 5759.9 5950.4 5980.2 625.0 630.2 633.5 636.2 638.3 3980.8 4082.2 4100.4 4145.2 4182.6 10055.8 10319.2 10357.0 10396.5 10410.6 10113.7 10207.7 10232.3 10236.1 10281.3 8001.9 8029.3 8039.2 8085.1 8109.4 5767.7 5781.0 5790.5 5799.9 5896.8 9260.5 9292.9 9365.7 9396.0 9449.4 9077.5 9373.2 9417.1 9580.9 9655.4 6939.6 7128.2 7210.1 7558.5 7575.2 8037.0 8385.0 8386.8 8389.2 8414.0 7365.8 7365.8 7383.8 7489.3 7767.3 7283.9 7335.4 7386.6 7407.3 7434.6 6550.1 6705.1 6709.7 6741.3 6746.1 4923.9 4927.2 4971.3 5021.8 5143.6 4943.2 4969.1 5042.8 5064.1 5080.6 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#4] prototype.html Cycles:180 Average:4835.30 Median:5443.52 stddev:1399.95 (25.7%) stddev-sans-first:1363.57 11:39:21 INFO - PROCESS | 8326 | Values: 391.7 407.2 413.8 415.8 417.4 5270.9 5417.8 5531.2 5604.5 5612.7 5326.9 5391.9 5400.6 5422.7 5445.5 4276.9 4289.7 4295.7 4303.4 4322.0 4026.9 4206.8 4320.2 4342.9 4350.8 4159.8 4176.2 4194.8 4200.0 4201.3 4205.6 4224.4 4237.9 4240.6 4264.0 3789.5 3795.4 3801.4 3804.7 3808.6 5253.7 5335.4 5349.7 5356.5 5379.1 4921.3 4962.5 4962.6 4987.5 5006.5 5457.4 5629.7 5753.3 5821.7 5823.7 4135.4 4147.0 4148.3 4154.9 4167.3 5980.6 6000.7 6006.5 6046.3 6065.3 4038.5 4283.5 4317.8 4322.5 4331.9 4293.7 4328.4 4335.4 4349.4 4364.3 4837.0 4893.4 4908.5 4933.4 4982.9 5516.8 5850.2 5859.6 5874.6 5874.7 1440.5 1455.5 1457.6 1458.8 1460.6 979.9 1004.7 1014.5 1023.7 1028.9 5367.8 5383.6 5389.6 5467.6 5495.2 5787.8 5816.7 5862.2 5864.0 5893.2 5270.0 5424.6 5441.6 5535.2 5620.5 3045.5 3046.8 3060.6 3069.5 3083.2 5755.2 6010.7 6013.8 6017.8 6039.5 5806.9 5851.9 5854.0 5854.4 5890.3 5974.3 5990.7 6004.1 6013.6 6028.5 5587.7 5675.8 5694.5 5694.7 5762.2 5588.0 5649.4 5691.3 5711.1 5761.0 5788.8 6018.7 6042.5 6053.4 6063.4 4411.5 4449.5 4518.5 4546.7 4555.7 5906.3 5916.4 5920.8 5938.8 5949.2 5570.2 5752.5 5783.5 5794.6 5827.4 5705.4 5730.4 5745.2 5765.2 5768.0 5765.1 5770.1 5773.2 5798.3 5820.9 5521.4 5747.1 5748.4 5791.8 5795.3 5648.9 5675.0 5693.9 5720.3 5730.8 11:39:21 INFO - PROCESS | 8326 | 11:39:21 INFO - PROCESS | 8326 | [#5] yui.html Cycles:180 Average:17578.87 Median:41630.40 stddev:21863.65 (52.5%) stddev-sans-first:21888.24 11:39:21 INFO - PROCESS | 8326 | Values: 698.6 736.3 771.1 809.7 813.9 15879.6 16726.0 16788.9 16816.7 16865.4 15545.1 15773.9 15773.9 15781.4 15800.1 643.3 659.5 736.1 744.5 755.9 774.9 776.8 777.1 777.4 778.2 803.7 804.3 811.0 811.7 813.7 803.5 803.9 804.6 804.8 806.1 593.8 594.7 594.9 596.4 598.1 15872.7 15907.9 16013.0 16142.8 16508.3 13886.3 14581.6 14634.6 14643.6 14700.2 11865.2 11907.2 11912.7 11930.9 11937.9 3653.1 3697.0 3728.1 3740.0 3856.7 75740.2 76062.2 76944.2 78074.6 78881.6 10262.7 10418.1 10439.3 10492.1 11505.2 21676.2 21998.9 22052.7 23389.4 23627.9 8166.8 8221.0 8257.1 8316.5 8394.2 4403.9 4420.9 4538.9 4545.4 4584.7 3708.5 3758.1 3759.0 3771.1 3815.3 608.3 613.5 614.0 629.2 631.1 728.4 738.3 747.3 755.6 773.9 10306.3 10432.9 10611.2 10728.4 10947.6 818.5 819.3 820.6 829.5 852.1 4785.9 5118.5 5177.8 5225.0 5242.5 79460.2 80744.6 81001.0 81079.6 81186.2 57474.0 68311.0 68649.3 68712.3 69224.7 51084.5 58805.4 59449.1 59748.1 60138.4 10481.5 10850.8 10970.2 10992.5 11069.6 41491.0 41769.8 42281.2 42629.9 43770.3 49415.5 52133.5 52159.7 54281.5 54479.2 13377.1 13384.8 13442.6 13627.9 13689.9 13827.2 14075.9 14563.1 15327.9 16621.0 13592.2 13636.9 13851.2 14195.1 15112.5 14514.9 14841.3 15180.8 15195.4 15204.1 13723.3 13739.5 13806.0 13957.6 14763.6 11077.3 11274.3 11556.6 11616.0 11846.8 11034.3 11167.3 11225.7 11400.8 11950.2 11:39:21 INFO - PROCESS | 8326 | -------- Summary: end -------- 11:39:21 INFO - PROCESS | 8326 | 11:39:22 INFO - TEST-INFO | 8326: exit 0 11:39:22 INFO - TEST-OK | dromaeo_css | took 1114290ms 11:39:22 INFO - TEST-START | kraken 11:39:22 INFO - operating with platform_type : linux_ 11:39:22 INFO - Initialising browser for kraken test... 11:39:22 INFO - TEST-INFO | started process 8680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstLRhU/profile http://localhost:41764/getInfo.html) 11:39:26 INFO - PROCESS | 8680 | __metrics Screen width/height:1600/1200 11:39:26 INFO - PROCESS | 8680 | colorDepth:24 11:39:26 INFO - PROCESS | 8680 | Browser inner width/height: 1024/697 11:39:26 INFO - PROCESS | 8680 | __metrics 11:39:26 ERROR - PROCESS | 8680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 11:39:27 INFO - TEST-INFO | 8680: exit 0 11:39:27 INFO - Browser initialized. 11:39:27 INFO - Running cycle 1/1 for kraken test... 11:39:27 INFO - TEST-INFO | started process 8805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstLRhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:39 INFO - PROCESS | 8805 | RSS: Main: 155394048 11:39:39 INFO - PROCESS | 8805 | 11:39:42 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41764/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:42 INFO - PROCESS | 8805 | RSS: Main: 161779712 11:39:42 INFO - PROCESS | 8805 | 11:39:45 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41764/tests/kraken/driver.html?testName=audio-dft) 11:39:46 INFO - PROCESS | 8805 | RSS: Main: 160473088 11:39:46 INFO - PROCESS | 8805 | 11:39:49 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41764/tests/kraken/driver.html?testName=audio-fft) 11:39:49 INFO - PROCESS | 8805 | RSS: Main: 156954624 11:39:49 INFO - PROCESS | 8805 | 11:39:51 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41764/tests/kraken/driver.html?testName=audio-oscillator) 11:39:52 INFO - PROCESS | 8805 | RSS: Main: 157782016 11:39:52 INFO - PROCESS | 8805 | 11:39:54 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:39:55 INFO - PROCESS | 8805 | RSS: Main: 158089216 11:39:55 INFO - PROCESS | 8805 | 11:39:58 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41764/tests/kraken/driver.html?testName=imaging-darkroom) 11:39:58 INFO - PROCESS | 8805 | RSS: Main: 161865728 11:39:58 INFO - PROCESS | 8805 | 11:40:02 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41764/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:02 INFO - PROCESS | 8805 | RSS: Main: 159965184 11:40:02 INFO - PROCESS | 8805 | 11:40:05 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41764/tests/kraken/driver.html?testName=json-parse-financial) 11:40:06 INFO - PROCESS | 8805 | RSS: Main: 160854016 11:40:06 INFO - PROCESS | 8805 | 11:40:07 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:08 INFO - PROCESS | 8805 | RSS: Main: 160661504 11:40:08 INFO - PROCESS | 8805 | 11:40:10 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:11 INFO - PROCESS | 8805 | RSS: Main: 160505856 11:40:11 INFO - PROCESS | 8805 | 11:40:13 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:13 INFO - PROCESS | 8805 | RSS: Main: 160948224 11:40:13 INFO - PROCESS | 8805 | 11:40:16 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:17 INFO - PROCESS | 8805 | RSS: Main: 161292288 11:40:17 INFO - PROCESS | 8805 | 11:40:20 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:20 INFO - PROCESS | 8805 | RSS: Main: 161312768 11:40:20 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:41764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41764/tests/kraken/driver.html?testName=ai-astar) 11:40:22 INFO - PROCESS | 8805 | RSS: Main: 163008512 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | __start_tp_report 11:40:22 INFO - PROCESS | 8805 | _x_x_mozilla_page_load 11:40:22 INFO - PROCESS | 8805 | _x_x_mozilla_page_load_details 11:40:22 INFO - PROCESS | 8805 | |i|pagename|runs| 11:40:22 INFO - PROCESS | 8805 | |0;ai-astar;105;112;113;112;113;113;114;111;112;114 11:40:22 INFO - PROCESS | 8805 | |1;audio-beat-detection;148;118;120;175;121;120;119;117;137;121 11:40:22 INFO - PROCESS | 8805 | |2;audio-dft;164;163;166;162;164;163;170;164;163;166 11:40:22 INFO - PROCESS | 8805 | |3;audio-fft;76;77;76;94;77;77;76;75;95;74 11:40:22 INFO - PROCESS | 8805 | |4;audio-oscillator;85;85;107;88;83;84;107;85;85;116 11:40:22 INFO - PROCESS | 8805 | |5;imaging-gaussian-blur;118;117;119;117;117;118;117;118;118;122 11:40:22 INFO - PROCESS | 8805 | |6;imaging-darkroom;147;149;147;147;147;147;147;148;148;148 11:40:22 INFO - PROCESS | 8805 | |7;imaging-desaturate;96;96;97;96;97;97;96;96;96;97 11:40:22 INFO - PROCESS | 8805 | |8;json-parse-financial;57;56;55;57;58;57;58;58;58;58 11:40:22 INFO - PROCESS | 8805 | |9;json-stringify-tinderbox;67;72;67;67;67;66;66;68;70;67 11:40:22 INFO - PROCESS | 8805 | |10;stanford-crypto-aes;83;89;82;83;89;84;91;88;82;81 11:40:22 INFO - PROCESS | 8805 | |11;stanford-crypto-ccm;140;126;134;137;127;135;138;132;174;130 11:40:22 INFO - PROCESS | 8805 | |12;stanford-crypto-pbkdf2;168;173;175;172;170;171;178;175;174;177 11:40:22 INFO - PROCESS | 8805 | |13;stanford-crypto-sha256-iterative;65;64;64;63;66;66;63;64;63;66 11:40:22 INFO - PROCESS | 8805 | __end_tp_report 11:40:22 INFO - PROCESS | 8805 | __start_cc_report 11:40:22 INFO - PROCESS | 8805 | _x_x_mozilla_cycle_collect,767 11:40:22 INFO - PROCESS | 8805 | __end_cc_report 11:40:22 INFO - PROCESS | 8805 | __startTimestamp1484077222670__endTimestamp 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | ------- Summary: start ------- 11:40:22 INFO - PROCESS | 8805 | Number of tests: 14 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 11:40:22 INFO - PROCESS | 8805 | Values: 105.0 112.0 113.0 112.0 113.0 113.0 114.0 111.0 112.0 114.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:121.00 stddev:18.83 (15.6%) stddev-sans-first:18.76 11:40:22 INFO - PROCESS | 8805 | Values: 148.0 118.0 120.0 175.0 121.0 120.0 119.0 117.0 137.0 121.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 11:40:22 INFO - PROCESS | 8805 | Values: 164.0 163.0 166.0 162.0 164.0 163.0 170.0 164.0 163.0 166.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#3] audio-fft Cycles:10 Average:79.70 Median:77.00 stddev:7.86 (10.2%) stddev-sans-first:8.22 11:40:22 INFO - PROCESS | 8805 | Values: 76.0 77.0 76.0 94.0 77.0 77.0 76.0 75.0 95.0 74.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:85.00 stddev:12.39 (14.6%) stddev-sans-first:12.84 11:40:22 INFO - PROCESS | 8805 | Values: 85.0 85.0 107.0 88.0 83.0 84.0 107.0 85.0 85.0 116.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 11:40:22 INFO - PROCESS | 8805 | Values: 118.0 117.0 119.0 117.0 117.0 118.0 117.0 118.0 118.0 122.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 11:40:22 INFO - PROCESS | 8805 | Values: 147.0 149.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 148.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:40:22 INFO - PROCESS | 8805 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 11:40:22 INFO - PROCESS | 8805 | Values: 57.0 56.0 55.0 57.0 58.0 57.0 58.0 58.0 58.0 58.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:1.89 (2.8%) stddev-sans-first:1.99 11:40:22 INFO - PROCESS | 8805 | Values: 67.0 72.0 67.0 67.0 67.0 66.0 66.0 68.0 70.0 67.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:3.65 (4.2%) stddev-sans-first:3.78 11:40:22 INFO - PROCESS | 8805 | Values: 83.0 89.0 82.0 83.0 89.0 84.0 91.0 88.0 82.0 81.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:136.00 stddev:13.69 (10.1%) stddev-sans-first:14.48 11:40:22 INFO - PROCESS | 8805 | Values: 140.0 126.0 134.0 137.0 127.0 135.0 138.0 132.0 174.0 130.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.50 stddev:3.13 (1.8%) stddev-sans-first:2.67 11:40:22 INFO - PROCESS | 8805 | Values: 168.0 173.0 175.0 172.0 170.0 171.0 178.0 175.0 174.0 177.0 11:40:22 INFO - PROCESS | 8805 | 11:40:22 INFO - PROCESS | 8805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.26 (2.0%) stddev-sans-first:1.32 11:40:22 INFO - PROCESS | 8805 | Values: 65.0 64.0 64.0 63.0 66.0 66.0 63.0 64.0 63.0 66.0 11:40:22 INFO - PROCESS | 8805 | -------- Summary: end -------- 11:40:22 INFO - PROCESS | 8805 | 11:40:23 INFO - TEST-INFO | 8805: exit 0 11:40:23 INFO - TEST-OK | kraken | took 61200ms 11:40:23 INFO - SUITE-END | took 1175s 11:40:23 INFO - Completed test suite (00:19:35) 11:40:23 INFO - javascript benchmark 11:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7357.919821122626, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.143251322143, 3182.9363412731745, 3211.9036428907143, 3211.9518207226897, 3212.903612891613, 5261.0, 5374.7043912584795, 5377.569794416447, 5403.0274550580925, 5418.647787893789, 5285.814996475124, 5422.75597598108, 5478.890422191554, 5501.4223506531835, 5570.3315602127805, 4833.75831208439, 4839.9274010889685, 4887.218045112782, 4942.332785074005, 4997.350344455234, 4786.760661966905, 4889.877753056185, 4960.280759289901, 4964.925526117111, 4977.55202031817, 4764.928526072112, 4911.238757992517, 4947.529984651488, 4954.5540901319055, 4973.825916092937, 4808.543188397131, 4839.709617422931, 4863.0, 4895.902081958377, 4973.7513124344, 4878.365812444395, 4885.2916327132725, 4887.0, 4910.0, 4916.901661966741, 5419.376771671269, 5433.782648694048, 5435.266239057716, 5448.237246785453, 5480.698561579112, 5660.0, 5702.059160238556, 5721.599488035839, 5743.741531631086, 5747.971260143672, 5825.854353641193, 5830.242068531106, 5834.5624078194305, 5838.620489668158, 5883.794067207627, 5441.646292990982, 5443.237946687467, 5446.754896029688, 5450.964316779799, 5451.48210919962, 5785.88428231433, 5835.56233282497, 5879.0, 5907.793227237026, 5945.0, 5715.085586306171, 5726.3700992890745, 5735.225744524436, 5784.4504772046585, 5788.247527821356, 5767.22142510764, 5778.711064446761, 5808.564357673192, 5821.359650438449, 5844.649321040752, 5657.915131273035, 5694.088945768657, 5699.344575373802, 5779.190913272145, 5782.219400380979, 5755.165501002331, 5766.5675074368755, 5774.2782152230975, 5780.335261444988, 5815.0, 4492.303692927601, 4529.297958816389, 4534.161180181677, 4556.977215113903, 4580.541945805459, 4051.088505086391, 4053.115995225746, 4055.918881622351, 4065.1869626074904, 4093.099518106012, 5314.2825718528275, 5328.520433161034, 5474.945250547523, 5503.807366742145, 5597.860053498695, 5869.970650146722, 5872.324682661463, 5872.7357268923, 5880.117982302689, 5902.026165682614, 5503.834884953458, 5522.171674248895, 5551.417101204315, 5552.0, 5554.250176226158, 4819.518048195152, 4897.2654101885, 4947.35684361038, 5036.84889453317, 5075.416327122354, 5946.167536544887, 6065.211522502046, 6076.635401875901, 6105.877882442326, 6120.510359171256, 5851.1515830205235, 5865.384134665798, 5866.970665146647, 5872.853178670396, 5877.676727779842, 5861.648301101947, 6071.939280607314, 6076.544259180668, 6087.299960504599, 6089.238845144357, 5580.86047848807, 5706.885862282648, 5712.428757124254, 5749.9712501437225, 5779.653220806765, 5797.9420205797405, 5803.65178089316, 5868.09044598088, 5869.618474799125, 5870.119482077723, 5670.829875103754, 5682.090865461506, 5708.286464191976, 5716.085426331767, 5718.628289161191, 5483.7806487740045, 5516.034693928626, 5663.065594176915, 5675.8864822704145, 5702.971485142548, 5699.629524080921, 5731.856703582277, 5734.770609175586, 5753.539716822561, 5775.48020678141, 5594.188842617879, 5642.520385767256, 5740.483356497935, 5789.45000224978, 5794.159846822272, 5514.944850551604, 5544.7227638618715, 5558.694271814928, 5632.239647647515, 5682.516986056232], "value": 5359.3992036293175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.382642919218, 572.86537663649, 573.7246121861504, 578.1299144787096, 603.1013789453715, 42208.0, 45018.0, 45256.3211551827, 49274.75362623182, 49511.50488495114, 45609.0, 46013.0, 46022.53977460224, 46080.308795368015, 46147.307790383085, 9104.908950910472, 9284.350095493319, 9287.11772381626, 9313.208377287938, 10424.63513777018, 10211.33626314291, 10550.630727924525, 10592.15262778976, 10593.523291451904, 10603.098736607397, 10619.46902654868, 10655.84016239757, 10669.306495077795, 10683.893161068407, 10688.251822372436, 10529.420881851494, 10530.894691053069, 10580.418077005761, 10606.310589811676, 10632.893671063268, 10287.845682314772, 10413.427261500614, 10481.109105726022, 10517.158627309796, 10520.631777887813, 39804.601953980666, 40142.397864032064, 40157.598424015676, 40293.79853100716, 40512.594874051174, 4125.958740412588, 4162.666986641092, 4229.767362795045, 4230.7038507304505, 4250.872473825791, 28721.569176462162, 29270.268243293875, 29680.0, 29739.0, 30811.075667730005, 4251.2347777400055, 4304.461942257218, 4347.130573885204, 4352.978235108836, 4414.183376075436, 336909.0, 338921.0, 339587.0, 341181.0, 341279.0, 54013.0, 54319.18521222185, 54333.0, 54396.45603543993, 54566.72716636391, 56586.0, 57090.0, 57160.71419642875, 57164.0, 57278.7136064317, 13508.729825403438, 13646.385912633956, 13819.585412437644, 13823.79264311036, 13844.377003034888, 11276.1542884284, 11360.602378916697, 11390.202685812079, 11402.486888090056, 11828.76342473163, 18127.456176314732, 18263.54341141482, 18289.451316460527, 18342.90828545849, 18347.63304733898, 7339.633018349061, 7358.889616655754, 7553.244675532403, 7563.9621801890635, 7589.392848572101, 950.3442624589012, 969.5685419988038, 973.2846357926918, 974.0357046523891, 974.4591751577942, 30939.535906961413, 31751.68248317487, 31910.840445798087, 32079.35841283208, 32240.516392254136, 1054.5939813171983, 1137.7383201863618, 1154.1574650505179, 1181.1613754234418, 1187.7861984842812, 16336.836631633769, 16943.83056169447, 17233.827661723473, 17412.738808917875, 17507.212175452136, 536017.0, 539988.0, 540534.0, 542881.0, 542898.0, 64367.356326437075, 64895.0, 65054.67472662701, 65056.0, 65152.67423662851, 1476.0258229568649, 1476.9852301477063, 1481.4222453243244, 1509.7881603450996, 1510.4335874047233, 30486.695133048386, 30956.845215773777, 31324.530132048494, 31344.68655313509, 32563.674363256065, 53147.73426132999, 54431.45568544264, 54574.18138728002, 54672.0, 54687.45312546983, 332884.0, 335460.0, 335728.0, 336349.0, 337594.0, 28684.139475814925, 46824.7658761704, 47430.0, 48313.0, 50285.49714502808, 48173.27740083972, 48267.75866120647, 49139.75430122826, 52662.210066849795, 53070.46929530655, 42192.15615687607, 44356.0, 44426.77786611046, 45137.32294015527, 46134.0, 43156.56843431525, 43811.780941095094, 44360.55639443564, 45057.0, 45497.545024549334, 44264.7786761077, 44634.3304850421, 44653.10693786041, 44825.55174448344, 47085.0, 34848.30303393969, 39099.413508796824, 39276.0, 40544.594554054085, 40713.0, 29687.85156074206, 29796.255093622833, 30001.69998299989, 30410.239744005692, 30557.54163687502], "value": 20828.572270665776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.2341075367554, 416.31723972684784, 426.3093788063337, 429.90756987247744, 448.8182286174099, 19236.615267694637, 20635.484112897186, 21138.260160894373, 21713.565728685455, 22105.0, 20819.895900520478, 21276.89361553194, 22123.225687100956, 22384.88807555964, 22404.43988900274, 5385.623006389555, 5675.460831221028, 5676.063449530822, 5679.744411501471, 5697.259356283677, 5411.053065713504, 5541.473560011793, 5592.748326325325, 5597.916031259534, 5600.075987462084, 5547.8890422191735, 5549.084401073818, 5577.69322687252, 5579.358373787006, 5601.495865372116, 5363.383210930734, 5461.2354270402175, 5466.316710411199, 5484.588655850807, 5505.834824955257, 5225.634205605609, 5353.223782551547, 5374.113271310229, 5377.865553361197, 5385.838424847261, 25410.36474088144, 25705.35736606581, 25725.614115788278, 26028.609570856454, 26096.0, 2635.934101647455, 2648.4041090754617, 2750.4911591355462, 3125.6718044605445, 3158.368326334742, 10917.0, 11026.558937642485, 11035.889641103566, 11042.944785276022, 11539.884601154048, 1995.9700604490945, 2022.393282015404, 2024.767151777535, 2032.3598066609118, 2036.2160568181357, 92445.07554924431, 93016.53491732565, 93623.53188234083, 96190.0, 100626.0, 12053.26348831865, 12309.0, 12431.689207769698, 12453.501859925682, 12541.0, 17351.39270125565, 17450.56373590645, 17521.912390437967, 17537.824621753873, 17607.823921760617, 7975.60121993898, 8095.919040809635, 8158.755237342889, 8215.835683286301, 8307.210814972568, 7324.670389832364, 7366.558006519626, 7444.106707195063, 7565.583892885834, 7608.201138880338, 5161.896762064737, 5223.112070947948, 5242.344706911636, 5243.9213411798855, 5331.20031995196, 2088.937331880046, 2120.204923153817, 2163.459135216196, 2215.977840221577, 2242.596332660104, 972.5331840716495, 972.6401231544373, 985.265976847239, 986.8569057486624, 1001.979960400788, 19949.60100797976, 20287.4928126798, 20297.49256268605, 20934.37196884096, 22618.0, 991.5934466868694, 994.3735446668552, 1016.8220561401873, 1018.8267994440963, 1024.830902901013, 10524.947375263075, 11204.383758893338, 11232.269902456314, 11305.604303849326, 11360.431978401048, 642332.0, 652242.0, 663405.0, 673571.0, 674632.7903930563, 93465.0, 93703.0, 110437.44781276042, 110730.0, 111174.0, 1066.7279843639822, 1112.7273817914663, 1125.606037886733, 1132.7369982469652, 1138.1577632551853, 17734.73397899007, 17769.378071767427, 17846.732299015785, 18137.183826728095, 18343.26626934908, 46309.0, 46555.767221163675, 46850.53149468462, 47786.0, 48327.32707216005, 57088.42911570831, 57915.0, 58737.706311468166, 64592.677036614514, 68058.65970670115, 7722.92277077222, 8488.236058754741, 9011.23404510624, 9235.861462077939, 9251.444913305224, 13814.378352974341, 14659.706805864036, 14742.852571474577, 14784.408623654934, 14860.256987150815, 11906.166568340133, 12154.696132596402, 12208.69478263015, 12282.631521054383, 12504.937475312565, 11719.238249514096, 11957.701057473285, 12077.818832717692, 12107.273563586214, 12295.754084918073, 12390.442430090487, 12525.373731313215, 12653.177543459646, 12919.935400322938, 13237.470501179845, 9169.174774270348, 9356.906430935876, 9371.34400591952, 9558.522073896416, 9699.078587534173, 9338.533073346442, 12098.0, 12625.558105466265, 12667.619971400873, 12748.362581870684], "value": 9846.042794101946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.9347079381428, 1472.5950363650002, 1487.7024595080984, 1492.2240434973814, 1518.1650092449154, 7660.540367577935, 7853.0, 8112.391570632197, 8550.102239264874, 8555.443896146753, 8219.71231006915, 8520.829583408344, 8571.142885711426, 8741.431806932545, 8754.824903501925, 2292.518571100071, 2338.5089131282452, 2341.250799744074, 2342.894569744357, 2346.9178578749747, 2317.409060689522, 2354.788069073783, 2360.881955902198, 2377.0491803278655, 2377.41753270449, 2311.0986715181007, 2317.0268487235317, 2328.231683544435, 2350.8119350452007, 2351.905923763047, 2263.4907145892207, 2282.805961493275, 2285.8399912006166, 2292.151903795598, 2292.7363353214428, 2293.1629955066446, 2296.2996286132725, 2310.364649721323, 2322.7096612923383, 2328.953420931572, 8526.190011948855, 8570.27152692022, 8572.82854342916, 8609.440386374865, 8642.870356944652, 5152.124138896396, 5200.713960732158, 5260.579153667697, 5276.736163191825, 5291.100512912814, 3095.31902981346, 3141.8900338488043, 3343.0806528204694, 3343.749218808575, 3347.062822409729, 1308.319673769644, 1317.0780453682364, 1330.3880215101065, 1365.242290528756, 1396.7093965895938, 11615.303081815118, 11651.94174029133, 11658.591949281734, 11666.475008624633, 11671.533138674527, 4280.76455794928, 4437.245668236407, 4477.507474177838, 4511.05267893746, 4577.748223847654, 9858.753531161636, 9912.454814985102, 9920.652777152909, 9985.850212246822, 9989.450580218012, 5155.690658560498, 5222.608304377187, 5223.216517522402, 5226.634135610547, 5232.659877107976, 4687.906241875144, 4843.24929635907, 4866.7079975201605, 4903.754812259373, 4952.232403977389, 3604.459331100356, 3657.104009517685, 3715.3498137825773, 3750.774953502799, 3770.170562476306, 1085.3325204998869, 1092.8852470490642, 1093.2128867215592, 1093.9015488606065, 1117.5529788084832, 932.5104320231933, 947.8104379124203, 951.509972364233, 953.5280036382036, 955.3599088610648, 5691.544676425876, 5726.484616384545, 5759.884802303931, 5950.434708702666, 5980.192673988956, 625.0031200235617, 630.168178005029, 633.4583930739244, 636.1507387637556, 638.250056183982, 3980.8208630611693, 4082.2039702258367, 4100.384942258685, 4145.150244199932, 4182.581741825793, 10055.849162262572, 10319.226058045677, 10357.0, 10396.48017599117, 10410.635627752992, 10113.747156321151, 10207.693769186937, 10232.283740138118, 10236.078752912124, 10281.280310378203, 8001.901912809226, 8029.317508011768, 8039.196080392031, 8085.110637829834, 8109.351251899834, 5767.711614419179, 5780.9883270428345, 5790.507806836466, 5799.884002320015, 5896.764129434775, 9260.53697315118, 9292.860607091034, 9365.672201472917, 9396.01341859095, 9449.43303401798, 9077.500737459502, 9373.20327772147, 9417.058294170529, 9580.904190958001, 9655.372400793925, 6939.618320992192, 7128.215896251305, 7210.062691850026, 7558.546487210785, 7575.24247575238, 8036.95981520112, 8385.0, 8386.832263354821, 8389.244967952913, 8414.0, 7365.7790266292095, 7365.7790266292095, 7383.8154046149275, 7489.251074892467, 7767.339776118867, 7283.927160728324, 7335.4498412618195, 7386.556806591621, 7407.333339999426, 7434.59109748969, 6550.115734375989, 6705.1283333166375, 6709.7316107355155, 6741.292164322872, 6746.089277947414, 4923.926141107814, 4927.187014142626, 4971.279164521196, 5021.815510253052, 5143.562797162133, 4943.159662857251, 4969.105560999054, 5042.848714538423, 5064.139096353555, 5080.644354895269], "value": 4468.285367426851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.69839223797675, 407.19172442701233, 413.755884028423, 415.8357448807719, 417.3822742341335, 5270.9458108378285, 5417.83746487605, 5531.22562841202, 5604.497189256715, 5612.69130197839, 5326.893462130764, 5391.946080539194, 5400.648957817739, 5422.674639521621, 5445.482679145475, 4276.87169384919, 4289.742615443083, 4295.677824163185, 4303.440552728141, 4322.017807712668, 4026.8590599329027, 4206.768627725474, 4320.222359975203, 4342.891427714317, 4350.847025538234, 4159.771212583307, 4176.18564379946, 4194.769287689176, 4199.971007103264, 4201.285781417151, 4205.621494065534, 4224.429701990222, 4237.915241695179, 4240.5759424057505, 4264.0, 3789.5263092113487, 3795.3737633290475, 3801.3917773156163, 3804.6766024887916, 3808.5620153682403, 5253.658512196695, 5335.386430560497, 5349.689326115126, 5356.54469370104, 5379.139337705988, 4921.335619691367, 4962.478939711351, 4962.578180854632, 4987.47631498691, 5006.5494105530315, 5457.426970168154, 5629.690367029812, 5753.252077229975, 5821.7380217890295, 5823.67969761663, 4135.441715368417, 4147.04617937876, 4148.2947898857265, 4154.875353739392, 4167.333226683716, 5980.641161530322, 6000.689734452224, 6006.489448396892, 6046.2744470663365, 6065.302490213638, 4038.4548086008012, 4283.528811830696, 4317.84887528935, 4322.524522302544, 4331.891702707395, 4293.656507479394, 4328.372386004012, 4335.3713711511655, 4349.391085248068, 4364.345348197796, 4836.951630483721, 4893.412790465096, 4908.4846091160625, 4933.371987244201, 4982.850514484571, 5516.751746171351, 5850.151727999416, 5859.560532960045, 5874.618149820248, 5874.735636896265, 1440.488626537585, 1455.5415044261024, 1457.6137323609253, 1458.7884756710218, 1460.6202387379146, 979.911807937289, 1004.7287232447198, 1014.4521958142668, 1023.65195833417, 1028.9125424339015, 5367.812126575629, 5383.569314454834, 5389.568834493231, 5467.644603100785, 5495.203195536625, 5787.768489260467, 5816.709164541756, 5862.237909071879, 5864.0, 5893.233879595625, 5270.021134043849, 5424.593155513352, 5441.564674826004, 5535.197396377503, 5620.49415552594, 3045.4974929136442, 3046.8019578727312, 3060.56153607804, 3069.4628440022907, 3083.182956516525, 5755.22304488897, 6010.729517171738, 6013.849653758691, 6017.849553761103, 6039.486643635252, 5806.938536819368, 5851.941480585225, 5853.990016838479, 5854.385289544622, 5890.263717035371, 5974.312954010171, 5990.700464976734, 6004.129401236796, 6013.579049466583, 6028.487578555784, 5587.7485513152815, 5675.829725108253, 5694.544436444991, 5694.743736531783, 5762.164486149569, 5587.972060139673, 5649.435056494318, 5691.288588926384, 5711.143328500758, 5760.963026655075, 5788.768449261982, 6018.668973206516, 6042.546808989431, 6053.424924632153, 6063.423974722395, 4411.514733379261, 4449.51055383914, 4518.514816850653, 4546.704464209815, 4555.703879247838, 5906.304487932191, 5916.437938395846, 5920.79277225295, 5938.841925824423, 5949.2266005419015, 5570.24801651788, 5752.482276594959, 5783.479486846204, 5794.594378393472, 5827.446392592697, 5705.4009329019855, 5730.426957304237, 5745.224394706661, 5765.164051212634, 5767.971160144172, 5765.068701984882, 5770.076787713946, 5773.24947756789, 5798.304203495439, 5820.854478638068, 5521.420250873601, 5747.1379293106365, 5748.425157484218, 5791.7683292667825, 5795.33353664334, 5648.858778530405, 5674.9853801899735, 5693.9430605693415, 5720.255322126792, 5730.799422020209], "value": 4407.215148081072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.6329159018156, 736.3299397548233, 771.0785611194622, 809.6680361051968, 813.8575749243881, 15879.603009924744, 16726.0, 16788.916055419722, 16816.663666726672, 16865.40971066013, 15545.06729596225, 15773.921130394332, 15773.921130394361, 15781.447649332276, 15800.130992795392, 643.3084434233194, 659.5284371674252, 736.0688728758125, 744.5197847388445, 755.9017327747385, 774.9380049596019, 776.8252143267777, 777.0869228656335, 777.3897490469982, 778.1557010643459, 803.6584451608072, 804.2600807257309, 811.0470197517923, 811.6550466051934, 813.6501304439089, 803.4937989066909, 803.8995125609329, 804.6379129391768, 804.8028233082873, 806.0730160315625, 593.7654626422539, 594.696704680616, 594.9048152295655, 596.4333882811303, 598.1356939222825, 15872.682546349124, 15907.92046039774, 16013.0, 16142.838571614251, 16508.33966641333, 13886.305684715824, 14581.562553123424, 14634.560963171121, 14643.56069317922, 14700.191489468076, 11865.169438139334, 11907.16649834512, 11912.702182445422, 11930.940345298304, 11937.94031029848, 3653.104989277644, 3696.9630303696886, 3728.086618778417, 3739.981300093509, 3856.730028897978, 75740.24259757443, 76062.23937760606, 76944.23055769426, 78074.60962695206, 78881.60559197282, 10262.743431414274, 10418.11446027081, 10439.321444106108, 10492.055714985536, 11505.194636375541, 21676.24133155332, 21998.89000554987, 22052.669209961863, 23389.41526461818, 23627.881860590587, 8166.836663266701, 8220.958895205606, 8257.133001034925, 8316.542590157478, 8394.24451799341, 4403.911921761611, 4420.889477763081, 4538.909221815546, 4545.36364908913, 4584.747838868828, 3708.49935258742, 3758.079270578671, 3758.962410375916, 3771.132639492877, 3815.313243616176, 608.2700759089022, 613.5214532664529, 614.0359635372512, 629.2103410220236, 631.0660222870177, 728.4027097779875, 738.2580506590842, 747.3236720767713, 755.5844285642875, 773.9226077392216, 10306.278560500694, 10432.947835260775, 10611.151107911348, 10728.371548970552, 10947.56209751617, 818.5088946631973, 819.2631620963596, 820.5527987246965, 829.4691397505601, 852.0754980845728, 4785.856424307276, 5118.539331460112, 5177.767000484987, 5224.973875130676, 5242.501962313574, 79460.20539794644, 80744.59627701824, 81001.0, 81079.59460202779, 81186.18813811787, 57474.0, 68311.0, 68649.31350686529, 68712.3128768716, 69224.6538767303, 51084.48915510871, 58805.41194588085, 59449.10826337608, 59748.10377844336, 60138.39861601416, 10481.528331224961, 10850.78298434011, 10970.232083754061, 10992.505337260003, 11069.612563560237, 41491.0, 41769.79115104405, 42281.154376911676, 42629.93425164271, 43770.34344484771, 49415.50584494109, 52133.47866521286, 52159.73920130375, 54281.457185427644, 54479.18281225864, 13377.063605547908, 13384.799228011392, 13442.596722098353, 13627.931860340635, 13689.931550342184, 13827.170369777845, 14075.859241407865, 14563.126212427289, 15327.923360383573, 16621.0, 13592.184468931895, 13636.863631363956, 13851.16892986424, 14195.148291102567, 15112.546623601309, 14514.854851451773, 14841.257937103317, 15180.848191517944, 15195.392184312504, 15204.087754734752, 13723.313834308045, 13739.450421983009, 13806.0, 13957.58127256184, 14763.630909227355, 11077.279976801483, 11274.267172633752, 11556.59551915679, 11616.0, 11846.763064738829, 11034.337939723322, 11167.329960202414, 11225.742938541216, 11400.771984560097, 11950.223235489666], "value": 7330.625063694608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 113.0, 113.0, 114.0, 111.0, 112.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 120.0, 175.0, 121.0, 120.0, 119.0, 117.0, 137.0, 121.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 162.0, 164.0, 163.0, 170.0, 164.0, 163.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 94.0, 77.0, 77.0, 76.0, 75.0, 95.0, 74.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 88.0, 83.0, 84.0, 107.0, 85.0, 85.0, 116.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 70.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 82.0, 83.0, 89.0, 84.0, 91.0, 88.0, 82.0, 81.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 126.0, 134.0, 137.0, 127.0, 135.0, 138.0, 132.0, 174.0, 130.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 175.0, 172.0, 170.0, 171.0, 178.0, 175.0, 174.0, 177.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 66.0, 66.0, 63.0, 64.0, 63.0, 66.0], "value": 64.4, "unit": "score"}]}]} 11:40:23 INFO - Return code: 0 11:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:23 ERROR - # TBPL SUCCESS # 11:40:23 INFO - Running post-action listener: _resource_record_post_action 11:40:23 INFO - [mozharness: 2017-01-10 19:40:23.991863Z] Finished run-tests step (success) 11:40:23 INFO - Running post-run listener: _resource_record_post_run 11:40:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404328448; Read time: 8; Write time: 224968 11:40:24 INFO - TinderboxPrint: CPU usage
13.4% 11:40:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:40:24 INFO - TinderboxPrint: I/O write bytes / time
404,328,448 / 224,968 11:40:24 INFO - TinderboxPrint: CPU idle
8,238.3 (86.5%) 11:40:24 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%) 11:40:24 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105426944; Read time: 0; Write time: 45412 11:40:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 298512384; Read time: 0; Write time: 179532 11:40:24 INFO - Running post-run listener: _upload_blobber_files 11:40:24 INFO - Blob upload gear active. 11:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:40:24 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'] 11:40:24 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 11:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:40:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:28 INFO - (blobuploader) - INFO - Done attempting. 11:40:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:40:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:29 INFO - (blobuploader) - INFO - Done attempting. 11:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:30 INFO - (blobuploader) - INFO - Done attempting. 11:40:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:40:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:40:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:31 INFO - (blobuploader) - INFO - Done attempting. 11:40:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:40:31 INFO - Return code: 0 11:40:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:40:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:40:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1454a5ce9ab466b3556dcfa99405df8429b755e4098769fa75ea3353188ea2713b22ee709ec5d3f9b9dfd189e221efd093f358070ca3a364e60177944f672269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4eaeaf9cff3ddc6d258feb5b060736d50330e6d25e14395e10a00750fb0ae274c0f7be49b75faa669bb9708184559b308373984fee7e1204529401ff2d39aba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6602af92ec8d24e030e5afdfdb12ec532403216a9d2adbd3ee3e1eff72f609de4840324941c686098eef13e119bc2cfa0d880a12930b224f50594b4178bfb5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5970a98653205324cea1499865b0b899e6a49ef8b0668ee724f445164a7a8b8f125279720c5aabacce3fc10faf9161748eeb92bac92695ebf1ad34bf816116d"} 11:40:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:40:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:40:31 INFO - Contents: 11:40:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1454a5ce9ab466b3556dcfa99405df8429b755e4098769fa75ea3353188ea2713b22ee709ec5d3f9b9dfd189e221efd093f358070ca3a364e60177944f672269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4eaeaf9cff3ddc6d258feb5b060736d50330e6d25e14395e10a00750fb0ae274c0f7be49b75faa669bb9708184559b308373984fee7e1204529401ff2d39aba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6602af92ec8d24e030e5afdfdb12ec532403216a9d2adbd3ee3e1eff72f609de4840324941c686098eef13e119bc2cfa0d880a12930b224f50594b4178bfb5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5970a98653205324cea1499865b0b899e6a49ef8b0668ee724f445164a7a8b8f125279720c5aabacce3fc10faf9161748eeb92bac92695ebf1ad34bf816116d"} 11:40:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:40:31 INFO - Copying logs to upload dir... 11:40:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:40:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.172377 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-10 11:40:31.265608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 11:40:31.269006) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1454a5ce9ab466b3556dcfa99405df8429b755e4098769fa75ea3353188ea2713b22ee709ec5d3f9b9dfd189e221efd093f358070ca3a364e60177944f672269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4eaeaf9cff3ddc6d258feb5b060736d50330e6d25e14395e10a00750fb0ae274c0f7be49b75faa669bb9708184559b308373984fee7e1204529401ff2d39aba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6602af92ec8d24e030e5afdfdb12ec532403216a9d2adbd3ee3e1eff72f609de4840324941c686098eef13e119bc2cfa0d880a12930b224f50594b4178bfb5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5970a98653205324cea1499865b0b899e6a49ef8b0668ee724f445164a7a8b8f125279720c5aabacce3fc10faf9161748eeb92bac92695ebf1ad34bf816116d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011840 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484069787/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1454a5ce9ab466b3556dcfa99405df8429b755e4098769fa75ea3353188ea2713b22ee709ec5d3f9b9dfd189e221efd093f358070ca3a364e60177944f672269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4eaeaf9cff3ddc6d258feb5b060736d50330e6d25e14395e10a00750fb0ae274c0f7be49b75faa669bb9708184559b308373984fee7e1204529401ff2d39aba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6602af92ec8d24e030e5afdfdb12ec532403216a9d2adbd3ee3e1eff72f609de4840324941c686098eef13e119bc2cfa0d880a12930b224f50594b4178bfb5dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5970a98653205324cea1499865b0b899e6a49ef8b0668ee724f445164a7a8b8f125279720c5aabacce3fc10faf9161748eeb92bac92695ebf1ad34bf816116d"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 11:40:31.321404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:40:31.321706) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484071287.491870-33957175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 11:40:31.373904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 11:40:31.374180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 11:40:31.374428) ========= ========= Total master_lag: 0.17 =========