builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1484163514.73 results: success (0) buildid: 20170111112315 builduid: 043130fef8a446f08dc517fc161fcc17 revision: 997c6b961cd04a8656d51fb05c4abac19f0463b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.725375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.725837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.726174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.740485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.740759) ========= 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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-11 11:38:34-- 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% 46.1M=0s 2017-01-11 11:38:35 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.842135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.842471) ========= 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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:34.892059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 11:38:34.892489) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 997c6b961cd04a8656d51fb05c4abac19f0463b4 --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 997c6b961cd04a8656d51fb05c4abac19f0463b4 --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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-11 11:38:35,144 truncating revision to first 12 chars 2017-01-11 11:38:35,144 Setting DEBUG logging. 2017-01-11 11:38:35,144 attempt 1/10 2017-01-11 11:38:35,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/997c6b961cd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 11:38:36,585 unpacking tar archive at: mozilla-inbound-997c6b961cd0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 11:38:36.658049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:36.658394) ========= script_repo_revision: 997c6b961cd04a8656d51fb05c4abac19f0463b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:36.658818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:36.659090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 11:38:36.667222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-11 11:38:36.667499) ========= /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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:37 INFO - MultiFileLogger online at 20170111 11:38:37 in /builds/slave/test 11:38:37 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:38:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:37 INFO - {'append_to_log': False, 11:38:37 INFO - 'base_work_dir': '/builds/slave/test', 11:38:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:38:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:37 INFO - 'branch': 'Mozilla-Inbound', 11:38:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:37 INFO - 'config_files': ('talos/linux_config.py',), 11:38:37 INFO - 'default_actions': ('clobber', 11:38:37 INFO - 'read-buildbot-config', 11:38:37 INFO - 'download-and-extract', 11:38:37 INFO - 'populate-webroot', 11:38:37 INFO - 'create-virtualenv', 11:38:37 INFO - 'install', 11:38:37 INFO - 'run-tests'), 11:38:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:37 INFO - 'download_minidump_stackwalk': True, 11:38:37 INFO - 'download_symbols': 'ondemand', 11:38:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:37 INFO - 'installer_path': 'installer.exe', 11:38:37 INFO - 'log_level': 'info', 11:38:37 INFO - 'log_name': 'talos', 11:38:37 INFO - 'log_to_console': True, 11:38:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:37 INFO - 'opt_config_files': (), 11:38:37 INFO - 'pip_index': False, 11:38:37 INFO - 'sps_profile': False, 11:38:37 INFO - 'sps_profile_interval': 0, 11:38:37 INFO - 'suite': 'dromaeojs-e10s', 11:38:37 INFO - 'system_bits': '32', 11:38:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:37 INFO - 'title': 'talos-linux64-ix-043', 11:38:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:37 INFO - 'use_talos_json': True, 11:38:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:37 INFO - 'work_dir': 'build'} 11:38:37 INFO - [mozharness: 2017-01-11 19:38:37.021602Z] Running clobber step. 11:38:37 INFO - Running pre-action listener: _resource_record_pre_action 11:38:37 INFO - Running main action method: clobber 11:38:37 INFO - rmtree: /builds/slave/test/build 11:38:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:38 INFO - Running post-action listener: _resource_record_post_action 11:38:38 INFO - [mozharness: 2017-01-11 19:38:38.037153Z] Finished clobber step (success) 11:38:38 INFO - [mozharness: 2017-01-11 19:38:38.037251Z] Running read-buildbot-config step. 11:38:38 INFO - Running pre-action listener: _resource_record_pre_action 11:38:38 INFO - Running main action method: read_buildbot_config 11:38:38 INFO - Using buildbot properties: 11:38:38 INFO - { 11:38:38 INFO - "project": "", 11:38:38 INFO - "product": "firefox", 11:38:38 INFO - "script_repo_revision": "production", 11:38:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:38:38 INFO - "repository": "", 11:38:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:38:38 INFO - "buildid": "20170111112315", 11:38:38 INFO - "stage_platform": "linux64-pgo", 11:38:38 INFO - "basedir": "/builds/slave/test", 11:38:38 INFO - "buildnumber": 1917, 11:38:38 INFO - "platform": "ubuntu64_hw", 11:38:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:38:38 INFO - "slavebuilddir": "test", 11:38:38 INFO - "branch": "mozilla-inbound", 11:38:38 INFO - "revision": "997c6b961cd04a8656d51fb05c4abac19f0463b4", 11:38:38 INFO - "slavename": "talos-linux64-ix-043", 11:38:38 INFO - "builduid": "043130fef8a446f08dc517fc161fcc17", 11:38:38 INFO - "repo_path": "integration/mozilla-inbound" 11:38:38 INFO - } 11:38:38 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:38:38 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:38:38 INFO - Running post-action listener: _resource_record_post_action 11:38:38 INFO - [mozharness: 2017-01-11 19:38:38.039672Z] Finished read-buildbot-config step (success) 11:38:38 INFO - [mozharness: 2017-01-11 19:38:38.039760Z] Running download-and-extract step. 11:38:38 INFO - Running pre-action listener: _resource_record_pre_action 11:38:38 INFO - Running main action method: download_and_extract 11:38:38 INFO - mkdir: /builds/slave/test/build/tests 11:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:38 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:38:38 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/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:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/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:38:38 INFO - Downloaded 1361 bytes. 11:38:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:38:38 INFO - Using the following test package requirements: 11:38:38 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:38:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'jsshell-linux-x86_64.zip'], 11:38:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:38:38 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:38:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:38 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:38:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:38 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:38:38 INFO - Expected file size: 21850073 11:38:38 INFO - Obtained file size: 21850073 11:38:42 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:38:42 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:38:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:38:42 INFO - Expected file size: 21850073 11:38:42 INFO - Obtained file size: 21850073 11:38:47 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:38:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:38:47 INFO - Expected file size: 14403529 11:38:47 INFO - Obtained file size: 14403529 11:38: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:38:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:38:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/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:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/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:38:48 INFO - Downloaded 61550084 bytes. 11:38:48 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:38:48 INFO - mkdir: /builds/slave/test/properties 11:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:48 INFO - Contents: 11:38:48 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:38:48 INFO - Running post-action listener: _resource_record_post_action 11:38:48 INFO - Running post-action listener: set_extra_try_arguments 11:38:48 INFO - [mozharness: 2017-01-11 19:38:48.561760Z] Finished download-and-extract step (success) 11:38:48 INFO - [mozharness: 2017-01-11 19:38:48.561988Z] Running populate-webroot step. 11:38:48 INFO - Running pre-action listener: _resource_record_pre_action 11:38:48 INFO - Running main action method: populate_webroot 11:38:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:48 INFO - '--tppagecycles', 11:38:48 INFO - '7'], 11:38:48 INFO - 'tests': ['tsvgm']}}, 11:38:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['damp', 'tps']}, 11:38:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'tests': ['damp', 'tps']}, 11:38:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['dromaeo_dom']}, 11:38:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['basic_compositor_video']}, 11:38:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['a11yr', 11:38:48 INFO - 'ts_paint', 11:38:48 INFO - 'tpaint', 11:38:48 INFO - 'sessionrestore', 11:38:48 INFO - 'sessionrestore_no_auto_restore', 11:38:48 INFO - 'tabpaint']}, 11:38:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['tsvgx', 11:38:48 INFO - 'tsvgr_opacity', 11:38:48 INFO - 'tart', 11:38:48 INFO - 'tscrollx', 11:38:48 INFO - 'cart', 11:38:48 INFO - 'tsvg_static']}, 11:38:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:48 INFO - 'tsvgr_opacity', 11:38:48 INFO - 'tart', 11:38:48 INFO - 'tscrollx', 11:38:48 INFO - 'cart', 11:38:48 INFO - 'tsvg_static']}, 11:38:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'talos_options': ['--disable-e10s'], 11:38:48 INFO - 'tests': ['tp5o']}, 11:38:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:38:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'talos_options': ['--disable-e10s', 11:38:48 INFO - '--xperf_path', 11:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:48 INFO - 'tests': ['tp5n']}, 11:38:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:38:48 INFO - 'talos_options': ['--xperf_path', 11:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:48 INFO - 'tests': ['tp5n']}}, 11:38:48 INFO - 'talos.zip': {'path': '', 11:38:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:48 INFO - Running post-action listener: _resource_record_post_action 11:38:48 INFO - [mozharness: 2017-01-11 19:38:48.583238Z] Finished populate-webroot step (success) 11:38:48 INFO - [mozharness: 2017-01-11 19:38:48.583327Z] Running create-virtualenv step. 11:38:48 INFO - Running pre-action listener: _resource_record_pre_action 11:38:48 INFO - Running main action method: create_virtualenv 11:38:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:38:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:48 INFO - Using real prefix '/usr' 11:38:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:51 INFO - Installing pip.................done. 11:38:51 INFO - Return code: 0 11:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:38:51 INFO - Reading from file tmpfile_stdout 11:38:51 INFO - Output received: 11:38:51 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:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:38:51 INFO - Using env: {'DISPLAY': ':0', 11:38:51 INFO - 'HOME': '/home/cltbld', 11:38:51 INFO - 'LANG': 'en_US.UTF-8', 11:38:51 INFO - 'LANGUAGE': 'en_US:en', 11:38:51 INFO - 'LOGNAME': 'cltbld', 11:38:51 INFO - 'MAIL': '/var/mail/cltbld', 11:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:51 INFO - 'MOZ_NO_REMOTE': '1', 11:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:51 INFO - 'NO_EM_RESTART': '1', 11:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:51 INFO - 'PWD': '/builds/slave/test', 11:38:51 INFO - 'SHELL': '/bin/bash', 11:38:51 INFO - 'SHLVL': '1', 11:38:51 INFO - 'TERM': 'linux', 11:38:51 INFO - 'TMOUT': '86400', 11:38:51 INFO - 'USER': 'cltbld', 11:38:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:51 INFO - '_': '/tools/buildbot/bin/python'} 11:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:38:51 INFO - Cleaning up... 11:38:51 INFO - Return code: 0 11:38:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:38:51 INFO - Using env: {'DISPLAY': ':0', 11:38:51 INFO - 'HOME': '/home/cltbld', 11:38:51 INFO - 'LANG': 'en_US.UTF-8', 11:38:51 INFO - 'LANGUAGE': 'en_US:en', 11:38:51 INFO - 'LOGNAME': 'cltbld', 11:38:51 INFO - 'MAIL': '/var/mail/cltbld', 11:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:51 INFO - 'MOZ_NO_REMOTE': '1', 11:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:51 INFO - 'NO_EM_RESTART': '1', 11:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:51 INFO - 'PWD': '/builds/slave/test', 11:38:51 INFO - 'SHELL': '/bin/bash', 11:38:51 INFO - 'SHLVL': '1', 11:38:51 INFO - 'TERM': 'linux', 11:38:51 INFO - 'TMOUT': '86400', 11:38:51 INFO - 'USER': 'cltbld', 11:38:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:51 INFO - '_': '/tools/buildbot/bin/python'} 11:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:51 INFO - Downloading/unpacking psutil>=3.1.1 11:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:53 INFO - Installing collected packages: psutil 11:38:53 INFO - Running setup.py install for psutil 11:38:53 INFO - building 'psutil._psutil_linux' extension 11:38:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:38:54 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:38:54 INFO - building 'psutil._psutil_posix' extension 11:38:54 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:38:54 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:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:54 INFO - Successfully installed psutil 11:38:54 INFO - Cleaning up... 11:38:54 INFO - Return code: 0 11:38:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:38:54 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:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:54 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:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:54 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:54 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:38:54 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:38:54 INFO - Using env: {'DISPLAY': ':0', 11:38:54 INFO - 'HOME': '/home/cltbld', 11:38:54 INFO - 'LANG': 'en_US.UTF-8', 11:38:54 INFO - 'LANGUAGE': 'en_US:en', 11:38:54 INFO - 'LOGNAME': 'cltbld', 11:38:54 INFO - 'MAIL': '/var/mail/cltbld', 11:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:54 INFO - 'MOZ_NO_REMOTE': '1', 11:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:54 INFO - 'NO_EM_RESTART': '1', 11:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:54 INFO - 'PWD': '/builds/slave/test', 11:38:54 INFO - 'SHELL': '/bin/bash', 11:38:54 INFO - 'SHLVL': '1', 11:38:54 INFO - 'TERM': 'linux', 11:38:54 INFO - 'TMOUT': '86400', 11:38:54 INFO - 'USER': 'cltbld', 11:38:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:54 INFO - '_': '/tools/buildbot/bin/python'} 11:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:56 INFO - Installing collected packages: mozsystemmonitor 11:38:56 INFO - Running setup.py install for mozsystemmonitor 11:38:56 INFO - Successfully installed mozsystemmonitor 11:38:56 INFO - Cleaning up... 11:38:56 INFO - Return code: 0 11:38:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:38:56 INFO - Using env: {'DISPLAY': ':0', 11:38:56 INFO - 'HOME': '/home/cltbld', 11:38:56 INFO - 'LANG': 'en_US.UTF-8', 11:38:56 INFO - 'LANGUAGE': 'en_US:en', 11:38:56 INFO - 'LOGNAME': 'cltbld', 11:38:56 INFO - 'MAIL': '/var/mail/cltbld', 11:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:56 INFO - 'MOZ_NO_REMOTE': '1', 11:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:56 INFO - 'NO_EM_RESTART': '1', 11:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:56 INFO - 'PWD': '/builds/slave/test', 11:38:56 INFO - 'SHELL': '/bin/bash', 11:38:56 INFO - 'SHLVL': '1', 11:38:56 INFO - 'TERM': 'linux', 11:38:56 INFO - 'TMOUT': '86400', 11:38:56 INFO - 'USER': 'cltbld', 11:38:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:56 INFO - '_': '/tools/buildbot/bin/python'} 11:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:57 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:38:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:59 INFO - warning: no files found matching '*.txt' 11:38:59 INFO - no previously-included directories found matching 'build' 11:38:59 INFO - no previously-included directories found matching 'dist' 11:38:59 INFO - no previously-included directories found matching '.git*' 11:38:59 INFO - Installing collected packages: jsonschema, functools32 11:38:59 INFO - Running setup.py install for functools32 11:38:59 INFO - warning: no files found matching '*.txt' 11:38:59 INFO - no previously-included directories found matching 'build' 11:38:59 INFO - no previously-included directories found matching 'dist' 11:38:59 INFO - no previously-included directories found matching '.git*' 11:38:59 INFO - Successfully installed jsonschema functools32 11:38:59 INFO - Cleaning up... 11:38:59 INFO - Return code: 0 11:38:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:38: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:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:59 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:59 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:38:59 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:38:59 INFO - Using env: {'DISPLAY': ':0', 11:38:59 INFO - 'HOME': '/home/cltbld', 11:38:59 INFO - 'LANG': 'en_US.UTF-8', 11:38:59 INFO - 'LANGUAGE': 'en_US:en', 11:38:59 INFO - 'LOGNAME': 'cltbld', 11:38:59 INFO - 'MAIL': '/var/mail/cltbld', 11:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:59 INFO - 'MOZ_NO_REMOTE': '1', 11:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:59 INFO - 'NO_EM_RESTART': '1', 11:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:59 INFO - 'PWD': '/builds/slave/test', 11:38:59 INFO - 'SHELL': '/bin/bash', 11:38:59 INFO - 'SHLVL': '1', 11:38:59 INFO - 'TERM': 'linux', 11:38:59 INFO - 'TMOUT': '86400', 11:38:59 INFO - 'USER': 'cltbld', 11:38:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:59 INFO - '_': '/tools/buildbot/bin/python'} 11:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:38:59 INFO - Cleaning up... 11:38:59 INFO - Return code: 0 11:38:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:38: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:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:59 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:38:59 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:38:59 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:38:59 INFO - Using env: {'DISPLAY': ':0', 11:38:59 INFO - 'HOME': '/home/cltbld', 11:38:59 INFO - 'LANG': 'en_US.UTF-8', 11:38:59 INFO - 'LANGUAGE': 'en_US:en', 11:38:59 INFO - 'LOGNAME': 'cltbld', 11:38:59 INFO - 'MAIL': '/var/mail/cltbld', 11:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:59 INFO - 'MOZ_NO_REMOTE': '1', 11:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:59 INFO - 'NO_EM_RESTART': '1', 11:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:59 INFO - 'PWD': '/builds/slave/test', 11:38:59 INFO - 'SHELL': '/bin/bash', 11:38:59 INFO - 'SHLVL': '1', 11:38:59 INFO - 'TERM': 'linux', 11:38:59 INFO - 'TMOUT': '86400', 11:38:59 INFO - 'USER': 'cltbld', 11:38:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:59 INFO - '_': '/tools/buildbot/bin/python'} 11:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:00 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:39:00 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:39:00 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:39:00 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:39:00 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:39:00 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:39:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:02 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:39:02 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:39:02 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:39:02 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:39:02 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:39:02 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:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:02 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:39:02 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:39:02 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:39:02 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:39:02 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:39:02 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:39:02 INFO - Downloading docopt-0.6.1.tar.gz 11:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:02 INFO - Running setup.py install for blobuploader 11:39:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:03 INFO - Running setup.py install for requests 11:39:03 INFO - Running setup.py install for docopt 11:39:03 INFO - Successfully installed blobuploader requests docopt 11:39:03 INFO - Cleaning up... 11:39:03 INFO - Return code: 0 11:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:03 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:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:03 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:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:03 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:39:03 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:39:03 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:39:03 INFO - Using env: {'DISPLAY': ':0', 11:39:03 INFO - 'HOME': '/home/cltbld', 11:39:03 INFO - 'LANG': 'en_US.UTF-8', 11:39:03 INFO - 'LANGUAGE': 'en_US:en', 11:39:03 INFO - 'LOGNAME': 'cltbld', 11:39:03 INFO - 'MAIL': '/var/mail/cltbld', 11:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:03 INFO - 'MOZ_NO_REMOTE': '1', 11:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:03 INFO - 'NO_EM_RESTART': '1', 11:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:03 INFO - 'PWD': '/builds/slave/test', 11:39:03 INFO - 'SHELL': '/bin/bash', 11:39:03 INFO - 'SHLVL': '1', 11:39:03 INFO - 'TERM': 'linux', 11:39:03 INFO - 'TMOUT': '86400', 11:39:03 INFO - 'USER': 'cltbld', 11:39:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:03 INFO - '_': '/tools/buildbot/bin/python'} 11:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:03 INFO - Running setup.py (path:/tmp/pip-S09ilI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:03 INFO - Running setup.py (path:/tmp/pip-99h1N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:03 INFO - Running setup.py (path:/tmp/pip-w2Kei1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:04 INFO - Running setup.py (path:/tmp/pip-zt4kM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:04 INFO - Running setup.py (path:/tmp/pip-aFkG08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:04 INFO - Running setup.py (path:/tmp/pip-4Dw98h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:04 INFO - Running setup.py (path:/tmp/pip-vrWpzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:04 INFO - Running setup.py (path:/tmp/pip-fXP1w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:04 INFO - Running setup.py (path:/tmp/pip-wBdStb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:04 INFO - Running setup.py (path:/tmp/pip-ILVgS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:04 INFO - Running setup.py (path:/tmp/pip-Schxae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:04 INFO - Running setup.py (path:/tmp/pip-7VGm00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:04 INFO - Running setup.py (path:/tmp/pip-PSjZpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:04 INFO - Running setup.py (path:/tmp/pip-fTuChK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:04 INFO - Running setup.py (path:/tmp/pip-fh82Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:04 INFO - Running setup.py (path:/tmp/pip-Hng094-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:04 INFO - Running setup.py (path:/tmp/pip-rA3Hem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:05 INFO - Running setup.py install for manifestparser 11:39:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Running setup.py install for mozcrash 11:39:05 INFO - Running setup.py install for mozdebug 11:39:05 INFO - Running setup.py install for mozdevice 11:39:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Running setup.py install for mozfile 11:39:05 INFO - Running setup.py install for mozhttpd 11:39:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Running setup.py install for mozinfo 11:39:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Running setup.py install for mozInstall 11:39:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:05 INFO - Running setup.py install for mozleak 11:39:05 INFO - Running setup.py install for mozlog 11:39:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for moznetwork 11:39:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozprocess 11:39:06 INFO - Running setup.py install for mozprofile 11:39:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozrunner 11:39:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozscreenshot 11:39:06 INFO - Running setup.py install for moztest 11:39:06 INFO - Running setup.py install for mozversion 11:39:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:06 INFO - Cleaning up... 11:39:06 INFO - Return code: 0 11:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:06 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:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:06 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:39:06 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:39:06 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:39:06 INFO - Using env: {'DISPLAY': ':0', 11:39:06 INFO - 'HOME': '/home/cltbld', 11:39:06 INFO - 'LANG': 'en_US.UTF-8', 11:39:06 INFO - 'LANGUAGE': 'en_US:en', 11:39:06 INFO - 'LOGNAME': 'cltbld', 11:39:06 INFO - 'MAIL': '/var/mail/cltbld', 11:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:06 INFO - 'MOZ_NO_REMOTE': '1', 11:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:06 INFO - 'NO_EM_RESTART': '1', 11:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:06 INFO - 'PWD': '/builds/slave/test', 11:39:06 INFO - 'SHELL': '/bin/bash', 11:39:06 INFO - 'SHLVL': '1', 11:39:06 INFO - 'TERM': 'linux', 11:39:06 INFO - 'TMOUT': '86400', 11:39:06 INFO - 'USER': 'cltbld', 11:39:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:06 INFO - '_': '/tools/buildbot/bin/python'} 11:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:07 INFO - Running setup.py (path:/tmp/pip-pCMTrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:07 INFO - Running setup.py (path:/tmp/pip-2ZuDoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:07 INFO - Running setup.py (path:/tmp/pip-A5pelA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:07 INFO - Running setup.py (path:/tmp/pip-syjmCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:07 INFO - Running setup.py (path:/tmp/pip-by0Y7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:07 INFO - Running setup.py (path:/tmp/pip-ySomRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:07 INFO - Running setup.py (path:/tmp/pip-Dep3DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:07 INFO - Running setup.py (path:/tmp/pip-tCN7T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:07 INFO - Running setup.py (path:/tmp/pip-BtOs79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:07 INFO - Running setup.py (path:/tmp/pip-qGOf31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:07 INFO - Running setup.py (path:/tmp/pip-vozHI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:07 INFO - Running setup.py (path:/tmp/pip-bcwf2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:07 INFO - Running setup.py (path:/tmp/pip-Hciym1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:08 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:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:08 INFO - Running setup.py (path:/tmp/pip-ecvAov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:08 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:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:08 INFO - Running setup.py (path:/tmp/pip-Uoe98f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:08 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:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:08 INFO - Running setup.py (path:/tmp/pip-Q3dHkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:08 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:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:08 INFO - Running setup.py (path:/tmp/pip-_jyZ0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:10 INFO - Downloading blessings-1.6.tar.gz 11:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:10 INFO - Installing collected packages: blessings 11:39:10 INFO - Running setup.py install for blessings 11:39:10 INFO - Successfully installed blessings 11:39:10 INFO - Cleaning up... 11:39:10 INFO - Return code: 0 11:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:10 INFO - Reading from file tmpfile_stdout 11:39:10 INFO - Current package versions: 11:39:10 INFO - argparse == 1.2.1 11:39:10 INFO - blessings == 1.6 11:39:10 INFO - blobuploader == 1.2.4 11:39:10 INFO - docopt == 0.6.1 11:39:10 INFO - functools32 == 3.2.3-2 11:39:10 INFO - jsonschema == 2.5.1 11:39:10 INFO - manifestparser == 1.1 11:39:10 INFO - mozInstall == 1.12 11:39:10 INFO - mozcrash == 1.0 11:39:10 INFO - mozdebug == 0.1 11:39:10 INFO - mozdevice == 0.49 11:39:10 INFO - mozfile == 1.2 11:39:10 INFO - mozhttpd == 0.7 11:39:10 INFO - mozinfo == 0.9 11:39:10 INFO - mozleak == 0.1 11:39:10 INFO - mozlog == 3.4 11:39:10 INFO - moznetwork == 0.27 11:39:10 INFO - mozprocess == 0.24 11:39:10 INFO - mozprofile == 0.28 11:39:10 INFO - mozrunner == 6.13 11:39:10 INFO - mozscreenshot == 0.1 11:39:10 INFO - mozsystemmonitor == 0.3 11:39:10 INFO - moztest == 0.8 11:39:10 INFO - mozversion == 1.4 11:39:10 INFO - psutil == 3.1.1 11:39:10 INFO - requests == 1.2.3 11:39:10 INFO - wsgiref == 0.1.2 11:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39: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:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:10 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:39:10 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:39:10 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:39:10 INFO - Using env: {'DISPLAY': ':0', 11:39:10 INFO - 'HOME': '/home/cltbld', 11:39:10 INFO - 'LANG': 'en_US.UTF-8', 11:39:10 INFO - 'LANGUAGE': 'en_US:en', 11:39:10 INFO - 'LOGNAME': 'cltbld', 11:39:10 INFO - 'MAIL': '/var/mail/cltbld', 11:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:10 INFO - 'MOZ_NO_REMOTE': '1', 11:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:10 INFO - 'NO_EM_RESTART': '1', 11:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:10 INFO - 'PWD': '/builds/slave/test', 11:39:10 INFO - 'SHELL': '/bin/bash', 11:39:10 INFO - 'SHLVL': '1', 11:39:10 INFO - 'TERM': 'linux', 11:39:10 INFO - 'TMOUT': '86400', 11:39:10 INFO - 'USER': 'cltbld', 11:39:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:10 INFO - '_': '/tools/buildbot/bin/python'} 11:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 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:39:10 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:11 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:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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 0x29931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d05480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, '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': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', '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:39:11 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:39:11 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:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:11 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Running post-action listener: _resource_record_post_action 11:39:11 INFO - Running post-action listener: _start_resource_monitoring 11:39:11 INFO - Starting resource monitoring. 11:39:11 INFO - [mozharness: 2017-01-11 19:39:11.281720Z] Finished create-virtualenv step (success) 11:39:11 INFO - [mozharness: 2017-01-11 19:39:11.282214Z] Running install step. 11:39:11 INFO - Running pre-action listener: _resource_record_pre_action 11:39:11 INFO - Running main action method: install 11:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:11 INFO - Reading from file tmpfile_stdout 11:39:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:11 INFO - Reading from file tmpfile_stdout 11:39:11 INFO - Output received: 11:39:11 INFO - Usage: mozinstall [options] installer 11:39:11 INFO - Options: 11:39:11 INFO - -h, --help show this help message and exit 11:39:11 INFO - -d DEST, --destination=DEST 11:39:11 INFO - Directory to install application into. [default: 11:39:11 INFO - "/builds/slave/test"] 11:39:11 INFO - --app=APP Application being installed. [default: firefox] 11:39:11 INFO - mkdir: /builds/slave/test/build/application 11:39:11 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:39:11 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:39:28 INFO - Reading from file tmpfile_stdout 11:39:28 INFO - Output received: 11:39:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:28 INFO - Running post-action listener: _resource_record_post_action 11:39:28 INFO - [mozharness: 2017-01-11 19:39:28.980996Z] Finished install step (success) 11:39:28 INFO - [mozharness: 2017-01-11 19:39:28.981271Z] Running run-tests step. 11:39:28 INFO - Running pre-action listener: _resource_record_pre_action 11:39:28 INFO - Running main action method: run_tests 11:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:28 INFO - Python 2.7.3 11:39:28 INFO - Return code: 0 11:39:28 INFO - grabbing minidump binary from tooltool 11:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:28 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 0x2d02820>, '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 0x2d03520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d039b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:28 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:39:28 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:39:28 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:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:29 INFO - Return code: 0 11:39:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:29 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:39:29 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:39:29 INFO - Using env: {'DISPLAY': ':0', 11:39:29 INFO - 'HOME': '/home/cltbld', 11:39:29 INFO - 'LANG': 'en_US.UTF-8', 11:39:29 INFO - 'LANGUAGE': 'en_US:en', 11:39:29 INFO - 'LOGNAME': 'cltbld', 11:39:29 INFO - 'MAIL': '/var/mail/cltbld', 11:39:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:29 INFO - 'MOZ_NO_REMOTE': '1', 11:39:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:29 INFO - 'NO_EM_RESTART': '1', 11:39:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:29 INFO - 'PWD': '/builds/slave/test', 11:39:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:29 INFO - 'SHELL': '/bin/bash', 11:39:29 INFO - 'SHLVL': '1', 11:39:29 INFO - 'TERM': 'linux', 11:39:29 INFO - 'TMOUT': '86400', 11:39:29 INFO - 'USER': 'cltbld', 11:39:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484163514.270621-457688300', 11:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:29 INFO - '_': '/tools/buildbot/bin/python'} 11:39:29 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/1484156384/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:39:29 INFO - mozversion application_buildid: 20170111093944 11:39:29 INFO - mozversion application_changeset: 997c6b961cd04a8656d51fb05c4abac19f0463b4 11:39:29 INFO - mozversion application_display_name: Nightly 11:39:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:29 INFO - mozversion application_name: Firefox 11:39:29 INFO - mozversion application_remotingname: firefox 11:39:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:39:29 INFO - mozversion application_vendor: Mozilla 11:39:29 INFO - mozversion application_version: 53.0a1 11:39:29 INFO - mozversion platform_buildid: 20170111093944 11:39:29 INFO - mozversion platform_changeset: 997c6b961cd04a8656d51fb05c4abac19f0463b4 11:39:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:39:29 INFO - mozversion platform_version: 53.0a1 11:39:29 INFO - using testdate: 1484163569 11:39:29 INFO - actual date: 1484163569 11:39:29 INFO - starting webserver on 'localhost:50380' 11:39:29 INFO - SUITE-START | Running 2 tests 11:39:29 INFO - TEST-START | dromaeo_css 11:39:29 INFO - operating with platform_type : linux_ 11:39:29 INFO - Initialising browser for dromaeo_css test... 11:39:29 INFO - TEST-INFO | started process 25346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFYvcE/profile http://localhost:50380/getInfo.html) 11:39:33 INFO - PROCESS | 25346 | __metrics Screen width/height:1600/1200 11:39:33 INFO - PROCESS | 25346 | colorDepth:24 11:39:33 INFO - PROCESS | 25346 | Browser inner width/height: 1024/697 11:39:33 INFO - PROCESS | 25346 | __metrics 11:39:34 ERROR - PROCESS | 25346 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 11:39:35 INFO - TEST-INFO | 25346: exit 0 11:39:35 INFO - Browser initialized. 11:39:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:35 INFO - TEST-INFO | started process 25467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFYvcE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:47 INFO - PROCESS | 25467 | RSS: Main: 155021312 11:39:47 INFO - PROCESS | 25467 | 11:42:47 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50380/tests/dromaeo/cssquery-ext.html) 11:42:49 INFO - PROCESS | 25467 | RSS: Main: 163278848 11:42:49 INFO - PROCESS | 25467 | 11:44:35 INFO - PROCESS | 25467 | ************************* 11:44:35 INFO - PROCESS | 25467 | A coding exception was thrown and uncaught in a Task. 11:44:35 INFO - PROCESS | 25467 | 11:44:35 INFO - PROCESS | 25467 | Full message: ReferenceError: fetch is not defined 11:44:35 INFO - PROCESS | 25467 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:44:35 INFO - PROCESS | 25467 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:44:35 INFO - PROCESS | 25467 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:44:35 INFO - PROCESS | 25467 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:44:35 INFO - PROCESS | 25467 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:44:35 INFO - PROCESS | 25467 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:44:35 INFO - PROCESS | 25467 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:44:35 INFO - PROCESS | 25467 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:44:35 INFO - PROCESS | 25467 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:44:35 INFO - PROCESS | 25467 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:44:35 INFO - PROCESS | 25467 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:44:35 INFO - PROCESS | 25467 | 11:44:35 INFO - PROCESS | 25467 | ************************* 11:45:51 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-ext.html (next: http://localhost:50380/tests/dromaeo/cssquery-jquery.html) 11:45:52 INFO - PROCESS | 25467 | RSS: Main: 160636928 11:45:52 INFO - PROCESS | 25467 | 11:48:53 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50380/tests/dromaeo/cssquery-mootools.html) 11:48:54 INFO - PROCESS | 25467 | RSS: Main: 166232064 11:48:54 INFO - PROCESS | 25467 | 11:51:56 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50380/tests/dromaeo/cssquery-prototype.html) 11:51:56 INFO - PROCESS | 25467 | RSS: Main: 160878592 11:51:56 INFO - PROCESS | 25467 | 11:54:59 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50380/tests/dromaeo/cssquery-yui.html) 11:55:00 INFO - PROCESS | 25467 | RSS: Main: 165224448 11:55:00 INFO - PROCESS | 25467 | 11:58:02 INFO - PROCESS | 25467 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-yui.html (next: http://localhost:50380/tests/dromaeo/cssquery-dojo.html) 11:58:03 INFO - PROCESS | 25467 | RSS: Main: 165056512 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | __start_tp_report 11:58:03 INFO - PROCESS | 25467 | _x_x_mozilla_page_load 11:58:03 INFO - PROCESS | 25467 | _x_x_mozilla_page_load_details 11:58:03 INFO - PROCESS | 25467 | |i|pagename|runs| 11:58:03 INFO - PROCESS | 25467 | |0;dojo.html;3158.968410315897;3174.492081266996;3179.976966760652;3202.5196220566913;3216.5979252593424;5238.711870847102;5348.064088784467;5363.249145119681;5377.462253774621;5428.185772134182;5264.315638966938;5297;5321.175217841241;5344.732763361836;5416.07926652469;4821.13219620469;4849.636277279201;4875.8781030474165;4974.875628109308;4987.476314986929;4864.270359446076;4991;5049.116404629193;5054.494550544953;5057.064443078024;4818.68678535894;4940.604751619898;4964.503549645025;4992.82525111623;4996.850094497153;4823.614110871122;4831.951680483186;4851.951480485185;4854.2718592211095;4966.677165984235;4867.172580661296;4873.244647079709;4895.265710143507;4904.877378065541;4905.754712264373;5289.7619607117385;5301.814436494704;5312.3093997780425;5343.599230057761;5344.866378340534;5617.971910140464;5628.831135065954;5656.632318899258;5659;5674;5762.596618236725;5764.481196692276;5771;5771.365149833515;5826.096954971986;5327.813526526592;5368.32895888014;5377.462253774669;5381.327334083239;5381.3811411687375;5743.282089738783;5758.596898217168;5773.422657734193;5818.8254352369495;5861.6189947653265;5549.861253468695;5613.494785469327;5617.662940223599;5665.971670141623;5699.943000570024;5666.490015898589;5673.432656734293;5720.656760594377;5735.283089613798;5743.684097374685;5526.088195447786;5575.135853942646;5585.134304182858;5675.744591493392;5682.176084467729;5670.716464176775;5689.971550142222;5690.089585666274;5693.572982026365;5695.943040569624;4401.471823381151;4439.955600444019;4440.267355886307;4440.777961101932;4442.8667139985855;3981.203759248162;4020.1758639478835;4057.6753859691153;4062.045419326456;4073.3889916512762;5469.288992430958;5499.092649712833;5513.641613295204;5522.806701765419;5524.226608274765;5593.860153496195;5628.774849005994;5792.073268277056;5827;5837.503812175928;5356.946430535722;5423.701696406735;5424.891502170013;5497.532709719719;5537.750801213955;4925.335079764258;4948.38145231846;4958.082754690394;4958.603311735053;4996.975015124974;5831.533477321719;5946.464818166386;5956.731947062306;5957.79147729836;5971.5222782177325;5646.3788983212635;5678.74445649955;5680.4319568042865;5786.710664466844;5801.738921748447;5907.763689452546;5925.407459254213;5939;5939.821805345847;5948.434898684618;5624.690642014729;5639.7180140993605;5643.379228284967;5647.068233741551;5653.123765816305;5559.499645031967;5595.972020139873;5705.515031222392;5709.600327977002;5756.366799652119;5623.775048997994;5657.3776884543495;5661.971690141688;5667.688277144632;5720.3707592165665;5632.493075623213;5643.068893632505;5650.971745141248;5692.5730570208225;5699.116636921284;5392.352917649907;5410;5426.755795989111;5515.806946757005;5606.607537472338;5597.944020559742;5601.719914004202;5606.0469720148485;5640.60515763909;5650.576206784425;5464.699441530595;5470.234167216513;5470.234167216672;5475.698836564027;5477.315335583052 11:58:03 INFO - PROCESS | 25467 | |1;ext.html;550.9035918714225;568.2499101186432;575.3383608849822;582.254713966123;590.8641012567109;43831.78084109579;45095.77452112739;46539.76730116349;51705.48294517063;51872.48127518724;48458;48935.51064489363;48961.755191223994;49029.50970490294;49123.263151052764;8977.730668079968;9183.816323673522;9185.632574697003;10492.737681557946;10756.085732712729;10612.734681632983;10695.304805187678;10704.090152337061;10706.250562460631;10735.463226838667;10750.354978701263;10762.515686794113;10762.892371076307;10785.676429707122;10831.620893268699;10571.73570660732;10633.149348052177;10652.307600006052;10677.305975111592;10710.732231694192;10608.15134789215;10670;10681.465926703711;10707.304025238334;10752.677419677422;40783;40965.79517102396;40982.59017409818;41016;41143.794281028706;3825.428612807696;3838.42423636454;3839.78881161536;3857.1128640412862;3928.3125453045886;30709.692903070907;30973.845130774203;30979.661420132474;30997.38005239905;31487.527687084712;4139.317012692902;4216.494020717503;4268.445102136733;4280.871573852789;4294.377315289296;330630;334096;334988;336502;336979;55852;56167.71916140475;56238;56394.43605563974;56559.717201414554;58438.12342814776;58707.30341572664;58735.41264587385;59070.70464647735;59236;16702.164891755365;17139.828601714074;17161.65676686459;17209.569760755832;17223.13884305805;12372.566960156351;12521.812172817416;12543.749125017448;12799.232046077264;12823.807642885364;18139.365122220657;18238.452846414628;18266.36067737623;18450;18628.441146765617;7057.89413158803;7158.2841715829045;7202.783916482514;7227.16887557927;7250.492465527468;926.8656044873455;946.6024269806697;949.8147861167006;964.252704154286;974.1248097412453;31018;31584.684153158632;31983.360332793214;32373.838130809665;32803.34393312121;1112.4882554025078;1115.4255558387438;1131.3890499130378;1143.7598104398169;1165.3241120150292;17148.657026859393;17267.309307627555;17284.22221000058;17335.91332043357;17504.91247543754;477201;479896;480685;480710;482159;65872.34127658758;66560.33439665638;66655.33344666589;66728.99626022358;66729.33270667231;1463.8389777124507;1514.7727840823964;1516.9696606067816;1517.2413793103449;1522.8401017893184;30553.847230763702;31463.84268078645;31911.84044079765;32094.67905320917;32162.678373216906;55512;57161.42773575116;57208.71395642995;57472;57522.712386439474;394680;395475;396076;396515;396714;25910.74089259083;26490.86754566215;29174.124776256747;44926.77536612296;45836.31245531253;46353.304700428846;51443.228351575504;51702.22446663379;52231.73884130555;52722.736386317825;42408.36387454129;42773;42921.785391074096;44340.55659443364;44999.32501012553;43605;43823.56176438322;43877.34183987179;44131.338029928935;45333.54666453293;44103.558964409945;44328.11343773171;44417.555824442636;44603.55396445994;45090.549094508635;36948.261034779694;39643;39830.80084599558;39835.20329593334;40459.79770101131;29250.707492924797;29394.82420703148;29613.85193074107;29938.25154371071;29975 11:58:03 INFO - PROCESS | 25467 | |2;jquery.html;425.1921349436073;429.0691982069323;430.7889134324181;431.26684636118597;441.9801108950099;19284.3250486233;20708.689369659467;21212.57574848504;21951;22065.227717029906;21295.68056479154;21552.137914483443;21561.1375544978;21592.2442714505;21733.67399489009;5736.426357364261;5938.792142275021;5940.168376427282;5956.315023772278;5961.254843144607;5622.943770562303;5729.226554415163;5735.827925162252;5737.397573254811;5754.97122514389;5520.392756796749;5699.145128230757;5703.116017017369;5719.370869204384;5723.828285151452;5735.541156707474;5765.769369225226;5770.538356931435;5822.82531524055;5825.271841019851;5186.974065129688;5221.634485586011;5234.947650523484;5248.868778280574;5256.92114618281;23980.64029039566;24457.877710611512;24727.25818225456;24795.13217037395;24861.254162375157;2702.162329677806;2715.954357572329;2731.262559109049;2739.5342791725257;2773;14930.059092318037;15295.694086118327;15537.844621553753;15644.921775391163;16042.83957160425;2010.7976263069436;2025.7771645119026;2033.1765634917733;2041.9591608167902;2079.376187143866;85379.57310213472;85638;87982;88160.11839881583;89912.55043724805;11339.603113890975;11353.148513861328;11525.76948461026;11544.422778861024;11579.536818527165;15851.762223566655;15976.360945562279;15983.44057957966;15995.280212390471;16022.118783467022;8407.495550267004;8479.279261262738;8610.397272191012;8660.913390866137;8669.176428239307;7964.721234756872;8047.235512626291;8106.513609183467;8303.916960830315;8357.414980951275;7080.185778635419;7128.287171282934;7144.8928266076055;7243.4929554931705;7348.963255183797;1977.891215983106;2046.8669536480081;2054.298597344487;2067.6174907642135;2118.6504226802713;985.6008316631633;988.7429268390271;995.4077323992213;995.4276291132628;999.9450030248406;19988.50028749264;20219.292324768856;20428.182872684927;20444.28445004418;20696.379108626767;1003.3779056984716;1005.1657124586576;1012.3116280928891;1026.414943482223;1029.711680729397;10997.945010274898;11765.88234117665;11828.290302581701;11869.46587403569;11952.462139203757;588028;631648;635231;642007;647019;86434;88424;89476.55261723649;89606.55196723975;91003.54498227466;1074.9465523786575;1125.8536390269212;1126.2904370246692;1135.6706555098929;1136.2160109524402;17904;18516.444506664822;18626.81373186251;18792.718109228645;18910.432687019413;36855.81572092122;39764.80117599393;41556.792216038724;43148.78425607852;45293.77353113213;57613.71193144008;58433.70783146057;59376;60257.698711506164;60466.39533604607;6579.440747536513;8755.956220218859;9032.63869445215;9079.90920090817;9383.765405864908;7715.652795624323;11632.302061876315;12146.60314063894;13258.403371848097;14134.08128471646;11712.238704484182;11834.881651183723;12025.819612705642;12086;12231.388430578614;11514.36670983104;11628.244164129304;11648.301101933912;11673.649790506299;11789.115816313639;11876;12136.939315303367;12205.450754715881;12292.508299667914;12531.122821402414;9085.90914090877;9191.862122068309;9200.493972831558;9224.44653320776;9459.621615135318;9376.859347109663;12084.577039803564;12213.816792748294;12305.692357691129;12443.37783110859 11:58:03 INFO - PROCESS | 25467 | |3;mootools.html;1395.7278330725505;1396.7136736968923;1401.0752903083967;1407.4088882669278;1407.957761267162;7421.2949769771785;7666.540007599534;8150.470219435732;8693.47839129652;8710.60802263898;8209.09699933007;8323.750287491384;8416.116307787686;8636.13638636136;8685.609147588359;2177.8693278403266;2222.9777702223014;2241.531796673182;2247.2471721973156;2251.167068184766;2169.858959167657;2232.520008198237;2235.5417139486367;2247.8876056197205;2291.9885400573057;2233.3300009997015;2239.8320125990535;2241.607718649238;2251.0883092347626;2254.165958595314;2213.9335819925427;2226.076178385968;2248.7751224877543;2252.8986195621237;2271.466205441728;2158.3093410108772;2221.8444708870384;2240.484688521633;2312.7571604981404;2319.408550819547;8563.687804292806;8574.571271436404;8577.313814894793;8613.956930215372;8621.525816080113;5163.044836705221;5249.291345668324;5270.183121616155;5283.682979021271;5294.788208471657;3161;3317.8672853085845;3375.662433756629;3381.2730262993573;3403.2172600301824;1296.556362125918;1325.8796317112026;1336.859629738873;2043.9591208175902;2053.7330147080784;11111.499982500725;11137.997580217738;11146.554137834477;11214.10287177024;11249;4261.957380426156;4376.562343765598;4458.9331160032625;4459.152760975404;4516.1419330327135;9119.589618467186;9259.537023148816;9275.536223188948;9328.766780830534;9352.392094513834;5277.050130976384;5293.761780719877;5293.947060529423;5297.390800057966;5297.788088476418;4710.882227944328;4808.543188397097;4871.123197824355;4878.268259760993;4915.754212289371;3406.131436483681;3489.877854275139;3529.2412131391875;3559.6440355964196;3562.928741425157;1039.184240371305;1059.7986382587283;1093.4805967165692;1106.1316866259947;1119.3004372267333;927.5779520318239;931.9953400233092;936.3445588088365;946.5503885654259;967.8161149381594;5230.084735171406;5459.50864422196;5506.862328441821;5572.637778544382;5583.302087239095;1015.1979935850743;1015.3958394755109;1018.251585084962;1046.858674079005;1049.9422531760827;3475.8957231283102;3572.732045096628;3680.9079773005888;3738.925221495555;3744.1575645480093;9969.202463802878;10293.176545876311;10333.586656533806;10452.790944181073;10479.318844275098;9932.304738668368;10219.897801022043;10244.282900196915;10321.48392580383;10342.32774869631;7982.560959147187;8014.959925200336;8027.397945154137;8098.473599215914;8098.4735992161495;5195.610329225399;5293.285406470077;5301.973490132679;5303.787848486171;5507.972460137674;9191.126842949909;9218.585163667785;9219.308551858772;9335.48654823964;9356.485393303434;9017.774555636162;9362.625494980124;9421;9424.387414818015;9681.757956051155;7439.367653749492;7550.848983020199;7559.811004724926;7572.962135189288;7576.469647124648;7165.605891675799;8070.838583228185;8073.19268073188;8106.756797296091;8153.268655000404;6830.146231721035;6833.077534532775;6836.111305530249;6885.173779146535;7091.503594748318;6525.836854078686;6541.6402097885075;6558.376954189344;6570.934290657032;6576.539642224999;5666.46168613981;5714.79998200061;5716.628419152742;5717.256756621613;5744.965906136768;4637.907241855211;4655.674102812771;4683.695559788603;4737.952620473751;4800.0399920016835;4500.662450316305;4528.41130653013;4538.818447262072;4573.611243044378;4573.748443835488 11:58:03 INFO - PROCESS | 25467 | |4;prototype.html;380.4787441205549;384.0590553144795;388.94360317753933;392.53680656824935;397.14217290652164;5164.509371609701;5339.679619222849;5369.731513424328;5444.945550544493;5472.480114389136;5243.2659427680155;5384.434634363394;5384.842258914333;5388.110961691326;5392.97763338748;4340.699429302459;4353.303471444569;4366.585174408426;4368.689393182032;4372.912541749163;3997.6801855851463;4192.454980852485;4371.890702732441;4390.990072283376;4393.604575588196;4142.917141657165;4170.332746760519;4173.520045194796;4174.70777045607;4178.892593462735;4144.150449157915;4144.1918825828825;4148.62662360386;4171.228322760299;4220.831166753326;3697.574778900434;3702.777833330009;3702.833372498244;3703.740738148331;3715.238376132886;5106.540411362995;5211.687298762048;5222.895542089137;5241.842744717665;5247.553957913582;4785.377900872899;4787.712737235742;4788.257820037899;4810.735409552473;4818.939833236717;5512.810264199197;5687.203791469197;5696.430356964312;5700.201971723962;5717.113847353667;3978.403239514096;4019.256437559061;4033.4353190553347;4049.8582549610624;4050.453188819501;5880.353161152269;5894.646321220741;5909.281730404019;5920;5956.851078723023;4110;4118;4122.670186385082;4127.29835927887;4134.276501612206;4023.8390464381096;4135.524414692289;4169.687273454503;4205.8527951522165;4215.220184265921;4727.905441891212;4778.426588809296;4778.976105119522;4780.402449693788;4809.3548548298995;5688.208214412447;5707.086866101404;5719.256496655491;5729.455701708331;5750.5112065474905;1466.7433199190311;1491.8955673102778;1493.6863258715573;1502.8647421731878;1506.5160816595644;1010.5604062232952;1023.6743417274647;1031.7781676939494;1042.7966546523355;1054.757405796671;5233.267342572043;5256.658317209369;5261.184516399964;5265.21021846726;5310.415854256029;5617.820257745919;5639.238702775073;5670.206171135962;5670.829875103754;5737.3688894221605;4994.450610432849;5211.2443695663915;5267.341582302212;5310.787568497294;5330.987112448623;2935.8678859451375;2959.230600044004;2965.8961936332125;2972.3758010817537;2993.3115383461927;5750.338711048199;5836.241288632451;5846.649201047951;5848.824535263949;5869.559783016291;5424.884295124904;5654.46282603152;5713.8285851424525;5717.313922329347;5727.5131613812455;5761;5764.452377024176;5767.942320576824;5781.595288329777;5783.971080144573;5391.32608423947;5645.745941432563;5646.237757902631;5650.915236271377;5745.396733342939;5753.784792854697;5768.769249229984;5779.479846813807;5786.971065144648;5799.710014499174;6039.245094363205;6044.909326360196;6080.817575472743;6081;6109.7861574844665;3951.0714981978635;4098.077932465171;4100.7334523255895;4121.91756164881;4142.2958097124165;5815.476607105381;5854.443827836349;5854.502367298827;5878.529717622494;5878.736071744595;5507.284053073075;5705.286839145107;5751.7411716472025;5753.683547404933;5771.971140144273;5643.209950607001;5661.2923384576925;5675.631083979528;5682.573806964577;5716.79991200306;5670.8015219467125;5675.914861277001;5676.574256930664;5702.946939101837;5721.942780572307;5500.779968801203;5666.688332141772;5710.057840456278;5712.685802280915;5754.625949313281;5598.720063996865;5602.635828671123;5617.297837770278;5617.859553511195;5642.319898048559 11:58:03 INFO - PROCESS | 25467 | |5;yui.html;638.763657446745;724.7535837815142;785.7367781793099;788.8777239527875;808.7735434078453;14087.718245635082;14984.400623975029;14989.925050374733;14995.40018399264;15017.62455938602;15138.54584362468;15310.770338444932;15317.693646127098;15344.923275383635;15359.078455292662;625.9123722678829;645.0614356111846;707.4941416886937;713.6645776485044;730.722325516303;741.7366834773659;744.5867543513348;745.4111252110825;745.6532712288785;746.5632604926097;772.6561680052379;778.5484419036974;779.0962483519119;782.2724865874734;782.7808213700173;773.5397438524097;777.3392616276177;779.4271210660161;779.8479296537178;780.9140994490601;568.4230506036376;568.5196009372115;568.7696482924422;569.049687022669;572.7336788393417;14551.3451894665;14729.189894555795;15213.087214767038;15224.238788060664;15298.847011529853;11419.48612312448;13207.801882971764;13939.930300348535;13971.301434928315;14045.43818247269;11382.715432114263;11578.421078946103;11724.648260552112;11831.112666549958;11883.40582970848;3687.631236876318;3700.0749812546865;3734.7945862977526;3811.1805961718087;3882.437046628251;73822;75615.62192189059;75958;76706;77343.6132819338;10945.233833631728;10972.835407468894;10975.176861735401;11091.83362249567;11107.389093599768;21021.894890525757;21138.894305528374;21170.47073823136;21218.469538261666;21240.575188496452;7127.358537731629;7243.058402407653;7485.663145158481;7490.475666703279;7655.846883062308;4353.869383918424;4415.4259946206785;4427.889302767457;4499.752513611717;4504.346869703874;3464.0300715799617;3567.9821600892346;3579.7673151245085;3580.6240344763423;3583.4087375582735;633.8573820890263;639.1052526462989;646.8415238266655;650.9446697030711;667.9799606011827;797.6649807081039;805.1264378149656;820.729159377404;827.8385714785559;839.5969934431507;9619.615215391446;9623.56693948774;10271.589136434459;10556.26106172576;10827.729306767236;606.8998615228438;610.9877802444015;622.8785386849612;628.1488582970101;634.2199095112944;4813.4945830687975;4975.601951843843;5007.198848184273;5023.522765337287;5025.6482046256415;80907.59546202232;81479;82300.58849705833;85150.57424712837;85531;63259.73480530456;70302;71549;71598.28401715917;73625.47808914246;63076.684616576626;63445.68277158677;65164.67417662881;66194.66902665552;66261.66869165623;9355.625774968925;9760.707178784647;10204.59181632756;10699.89300106989;10912.181586380895;40313;40851.387229190994;41008.1798364037;41126.58873411347;42226.788866055475;49688.75155624199;51074;51574.484255158466;52661.21008184804;53105.73447132894;12374.443150058449;12476.625701228977;12710.173838700455;12717.491300348252;12883.291418971672;13166.736665266833;13317.13438626525;13362.198268103944;13441.596752097452;13547.864521355055;12237.877621223673;12276;12327.312430513792;12644.936775316064;13803;12793.936030319788;13146;13246.403911824184;13401.463941442624;13882.5734912848;12546.560870369492;12978.480860765463;13264.86735132675;13717;13800.378982945993;11033.337999720043;11220.688797712297;11383.829242561535;11577.594784182513;11867.465964031811;10282.640107596199;10695.572177112828;10872.945635271773;10975.396353200651;11028.338299701723 11:58:03 INFO - PROCESS | 25467 | __end_tp_report 11:58:03 INFO - PROCESS | 25467 | __start_cc_report 11:58:03 INFO - PROCESS | 25467 | _x_x_mozilla_cycle_collect,328 11:58:03 INFO - PROCESS | 25467 | __end_cc_report 11:58:03 INFO - PROCESS | 25467 | __startTimestamp1484164683113__endTimestamp 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | ------- Summary: start ------- 11:58:03 INFO - PROCESS | 25467 | Number of tests: 6 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#0] dojo.html Cycles:165 Average:5330.53 Median:5524.23 stddev:571.89 (10.4%) stddev-sans-first:547.69 11:58:03 INFO - PROCESS | 25467 | Values: 3159.0 3174.5 3180.0 3202.5 3216.6 5238.7 5348.1 5363.2 5377.5 5428.2 5264.3 5297.0 5321.2 5344.7 5416.1 4821.1 4849.6 4875.9 4974.9 4987.5 4864.3 4991.0 5049.1 5054.5 5057.1 4818.7 4940.6 4964.5 4992.8 4996.9 4823.6 4832.0 4852.0 4854.3 4966.7 4867.2 4873.2 4895.3 4904.9 4905.8 5289.8 5301.8 5312.3 5343.6 5344.9 5618.0 5628.8 5656.6 5659.0 5674.0 5762.6 5764.5 5771.0 5771.4 5826.1 5327.8 5368.3 5377.5 5381.3 5381.4 5743.3 5758.6 5773.4 5818.8 5861.6 5549.9 5613.5 5617.7 5666.0 5699.9 5666.5 5673.4 5720.7 5735.3 5743.7 5526.1 5575.1 5585.1 5675.7 5682.2 5670.7 5690.0 5690.1 5693.6 5695.9 4401.5 4440.0 4440.3 4440.8 4442.9 3981.2 4020.2 4057.7 4062.0 4073.4 5469.3 5499.1 5513.6 5522.8 5524.2 5593.9 5628.8 5792.1 5827.0 5837.5 5356.9 5423.7 5424.9 5497.5 5537.8 4925.3 4948.4 4958.1 4958.6 4997.0 5831.5 5946.5 5956.7 5957.8 5971.5 5646.4 5678.7 5680.4 5786.7 5801.7 5907.8 5925.4 5939.0 5939.8 5948.4 5624.7 5639.7 5643.4 5647.1 5653.1 5559.5 5596.0 5705.5 5709.6 5756.4 5623.8 5657.4 5662.0 5667.7 5720.4 5632.5 5643.1 5651.0 5692.6 5699.1 5392.4 5410.0 5426.8 5515.8 5606.6 5597.9 5601.7 5606.0 5640.6 5650.6 5464.7 5470.2 5470.2 5475.7 5477.3 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#1] ext.html Cycles:180 Average:58481.65 Median:396614.50 stddev:107487.37 (27.1%) stddev-sans-first:107700.89 11:58:03 INFO - PROCESS | 25467 | Values: 550.9 568.2 575.3 582.3 590.9 43831.8 45095.8 46539.8 51705.5 51872.5 48458.0 48935.5 48961.8 49029.5 49123.3 8977.7 9183.8 9185.6 10492.7 10756.1 10612.7 10695.3 10704.1 10706.3 10735.5 10750.4 10762.5 10762.9 10785.7 10831.6 10571.7 10633.1 10652.3 10677.3 10710.7 10608.2 10670.0 10681.5 10707.3 10752.7 40783.0 40965.8 40982.6 41016.0 41143.8 3825.4 3838.4 3839.8 3857.1 3928.3 30709.7 30973.8 30979.7 30997.4 31487.5 4139.3 4216.5 4268.4 4280.9 4294.4 330630.0 334096.0 334988.0 336502.0 336979.0 55852.0 56167.7 56238.0 56394.4 56559.7 58438.1 58707.3 58735.4 59070.7 59236.0 16702.2 17139.8 17161.7 17209.6 17223.1 12372.6 12521.8 12543.7 12799.2 12823.8 18139.4 18238.5 18266.4 18450.0 18628.4 7057.9 7158.3 7202.8 7227.2 7250.5 926.9 946.6 949.8 964.3 974.1 31018.0 31584.7 31983.4 32373.8 32803.3 1112.5 1115.4 1131.4 1143.8 1165.3 17148.7 17267.3 17284.2 17335.9 17504.9 477201.0 479896.0 480685.0 480710.0 482159.0 65872.3 66560.3 66655.3 66729.0 66729.3 1463.8 1514.8 1517.0 1517.2 1522.8 30553.8 31463.8 31911.8 32094.7 32162.7 55512.0 57161.4 57208.7 57472.0 57522.7 394680.0 395475.0 396076.0 396515.0 396714.0 25910.7 26490.9 29174.1 44926.8 45836.3 46353.3 51443.2 51702.2 52231.7 52722.7 42408.4 42773.0 42921.8 44340.6 44999.3 43605.0 43823.6 43877.3 44131.3 45333.5 44103.6 44328.1 44417.6 44603.6 45090.5 36948.3 39643.0 39830.8 39835.2 40459.8 29250.7 29394.8 29613.9 29938.3 29975.0 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#2] jquery.html Cycles:180 Average:33503.17 Median:2735.40 stddev:103090.89 (3768.8%) stddev-sans-first:103350.16 11:58:03 INFO - PROCESS | 25467 | Values: 425.2 429.1 430.8 431.3 442.0 19284.3 20708.7 21212.6 21951.0 22065.2 21295.7 21552.1 21561.1 21592.2 21733.7 5736.4 5938.8 5940.2 5956.3 5961.3 5622.9 5729.2 5735.8 5737.4 5755.0 5520.4 5699.1 5703.1 5719.4 5723.8 5735.5 5765.8 5770.5 5822.8 5825.3 5187.0 5221.6 5234.9 5248.9 5256.9 23980.6 24457.9 24727.3 24795.1 24861.3 2702.2 2716.0 2731.3 2739.5 2773.0 14930.1 15295.7 15537.8 15644.9 16042.8 2010.8 2025.8 2033.2 2042.0 2079.4 85379.6 85638.0 87982.0 88160.1 89912.6 11339.6 11353.1 11525.8 11544.4 11579.5 15851.8 15976.4 15983.4 15995.3 16022.1 8407.5 8479.3 8610.4 8660.9 8669.2 7964.7 8047.2 8106.5 8303.9 8357.4 7080.2 7128.3 7144.9 7243.5 7349.0 1977.9 2046.9 2054.3 2067.6 2118.7 985.6 988.7 995.4 995.4 999.9 19988.5 20219.3 20428.2 20444.3 20696.4 1003.4 1005.2 1012.3 1026.4 1029.7 10997.9 11765.9 11828.3 11869.5 11952.5 588028.0 631648.0 635231.0 642007.0 647019.0 86434.0 88424.0 89476.6 89606.6 91003.5 1074.9 1125.9 1126.3 1135.7 1136.2 17904.0 18516.4 18626.8 18792.7 18910.4 36855.8 39764.8 41556.8 43148.8 45293.8 57613.7 58433.7 59376.0 60257.7 60466.4 6579.4 8756.0 9032.6 9079.9 9383.8 7715.7 11632.3 12146.6 13258.4 14134.1 11712.2 11834.9 12025.8 12086.0 12231.4 11514.4 11628.2 11648.3 11673.6 11789.1 11876.0 12136.9 12205.5 12292.5 12531.1 9085.9 9191.9 9200.5 9224.4 9459.6 9376.9 12084.6 12213.8 12305.7 12443.4 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#3] mootools.html Cycles:180 Average:5417.13 Median:4874.70 stddev:3021.96 (62.0%) stddev-sans-first:3015.33 11:58:03 INFO - PROCESS | 25467 | Values: 1395.7 1396.7 1401.1 1407.4 1408.0 7421.3 7666.5 8150.5 8693.5 8710.6 8209.1 8323.8 8416.1 8636.1 8685.6 2177.9 2223.0 2241.5 2247.2 2251.2 2169.9 2232.5 2235.5 2247.9 2292.0 2233.3 2239.8 2241.6 2251.1 2254.2 2213.9 2226.1 2248.8 2252.9 2271.5 2158.3 2221.8 2240.5 2312.8 2319.4 8563.7 8574.6 8577.3 8614.0 8621.5 5163.0 5249.3 5270.2 5283.7 5294.8 3161.0 3317.9 3375.7 3381.3 3403.2 1296.6 1325.9 1336.9 2044.0 2053.7 11111.5 11138.0 11146.6 11214.1 11249.0 4262.0 4376.6 4458.9 4459.2 4516.1 9119.6 9259.5 9275.5 9328.8 9352.4 5277.1 5293.8 5293.9 5297.4 5297.8 4710.9 4808.5 4871.1 4878.3 4915.8 3406.1 3489.9 3529.2 3559.6 3562.9 1039.2 1059.8 1093.5 1106.1 1119.3 927.6 932.0 936.3 946.6 967.8 5230.1 5459.5 5506.9 5572.6 5583.3 1015.2 1015.4 1018.3 1046.9 1049.9 3475.9 3572.7 3680.9 3738.9 3744.2 9969.2 10293.2 10333.6 10452.8 10479.3 9932.3 10219.9 10244.3 10321.5 10342.3 7982.6 8015.0 8027.4 8098.5 8098.5 5195.6 5293.3 5302.0 5303.8 5508.0 9191.1 9218.6 9219.3 9335.5 9356.5 9017.8 9362.6 9421.0 9424.4 9681.8 7439.4 7550.8 7559.8 7573.0 7576.5 7165.6 8070.8 8073.2 8106.8 8153.3 6830.1 6833.1 6836.1 6885.2 7091.5 6525.8 6541.6 6558.4 6570.9 6576.5 5666.5 5714.8 5716.6 5717.3 5745.0 4637.9 4655.7 4683.7 4738.0 4800.0 4500.7 4528.4 4538.8 4573.6 4573.7 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#4] prototype.html Cycles:180 Average:4744.26 Median:5320.89 stddev:1378.93 (25.9%) stddev-sans-first:1343.34 11:58:03 INFO - PROCESS | 25467 | Values: 380.5 384.1 388.9 392.5 397.1 5164.5 5339.7 5369.7 5444.9 5472.5 5243.3 5384.4 5384.8 5388.1 5393.0 4340.7 4353.3 4366.6 4368.7 4372.9 3997.7 4192.5 4371.9 4391.0 4393.6 4142.9 4170.3 4173.5 4174.7 4178.9 4144.2 4144.2 4148.6 4171.2 4220.8 3697.6 3702.8 3702.8 3703.7 3715.2 5106.5 5211.7 5222.9 5241.8 5247.6 4785.4 4787.7 4788.3 4810.7 4818.9 5512.8 5687.2 5696.4 5700.2 5717.1 3978.4 4019.3 4033.4 4049.9 4050.5 5880.4 5894.6 5909.3 5920.0 5956.9 4110.0 4118.0 4122.7 4127.3 4134.3 4023.8 4135.5 4169.7 4205.9 4215.2 4727.9 4778.4 4779.0 4780.4 4809.4 5688.2 5707.1 5719.3 5729.5 5750.5 1466.7 1491.9 1493.7 1502.9 1506.5 1010.6 1023.7 1031.8 1042.8 1054.8 5233.3 5256.7 5261.2 5265.2 5310.4 5617.8 5639.2 5670.2 5670.8 5737.4 4994.5 5211.2 5267.3 5310.8 5331.0 2935.9 2959.2 2965.9 2972.4 2993.3 5750.3 5836.2 5846.6 5848.8 5869.6 5424.9 5654.5 5713.8 5717.3 5727.5 5761.0 5764.5 5767.9 5781.6 5784.0 5391.3 5645.7 5646.2 5650.9 5745.4 5753.8 5768.8 5779.5 5787.0 5799.7 6039.2 6044.9 6080.8 6081.0 6109.8 3951.1 4098.1 4100.7 4121.9 4142.3 5815.5 5854.4 5854.5 5878.5 5878.7 5507.3 5705.3 5751.7 5753.7 5772.0 5643.2 5661.3 5675.6 5682.6 5716.8 5670.8 5675.9 5676.6 5702.9 5721.9 5500.8 5666.7 5710.1 5712.7 5754.6 5598.7 5602.6 5617.3 5617.9 5642.3 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - PROCESS | 25467 | [#5] yui.html Cycles:180 Average:17421.04 Median:23290.33 stddev:22560.96 (96.9%) stddev-sans-first:22589.06 11:58:03 INFO - PROCESS | 25467 | Values: 638.8 724.8 785.7 788.9 808.8 14087.7 14984.4 14989.9 14995.4 15017.6 15138.5 15310.8 15317.7 15344.9 15359.1 625.9 645.1 707.5 713.7 730.7 741.7 744.6 745.4 745.7 746.6 772.7 778.5 779.1 782.3 782.8 773.5 777.3 779.4 779.8 780.9 568.4 568.5 568.8 569.0 572.7 14551.3 14729.2 15213.1 15224.2 15298.8 11419.5 13207.8 13939.9 13971.3 14045.4 11382.7 11578.4 11724.6 11831.1 11883.4 3687.6 3700.1 3734.8 3811.2 3882.4 73822.0 75615.6 75958.0 76706.0 77343.6 10945.2 10972.8 10975.2 11091.8 11107.4 21021.9 21138.9 21170.5 21218.5 21240.6 7127.4 7243.1 7485.7 7490.5 7655.8 4353.9 4415.4 4427.9 4499.8 4504.3 3464.0 3568.0 3579.8 3580.6 3583.4 633.9 639.1 646.8 650.9 668.0 797.7 805.1 820.7 827.8 839.6 9619.6 9623.6 10271.6 10556.3 10827.7 606.9 611.0 622.9 628.1 634.2 4813.5 4975.6 5007.2 5023.5 5025.6 80907.6 81479.0 82300.6 85150.6 85531.0 63259.7 70302.0 71549.0 71598.3 73625.5 63076.7 63445.7 65164.7 66194.7 66261.7 9355.6 9760.7 10204.6 10699.9 10912.2 40313.0 40851.4 41008.2 41126.6 42226.8 49688.8 51074.0 51574.5 52661.2 53105.7 12374.4 12476.6 12710.2 12717.5 12883.3 13166.7 13317.1 13362.2 13441.6 13547.9 12237.9 12276.0 12327.3 12644.9 13803.0 12793.9 13146.0 13246.4 13401.5 13882.6 12546.6 12978.5 13264.9 13717.0 13800.4 11033.3 11220.7 11383.8 11577.6 11867.5 10282.6 10695.6 10872.9 10975.4 11028.3 11:58:03 INFO - PROCESS | 25467 | -------- Summary: end -------- 11:58:03 INFO - PROCESS | 25467 | 11:58:03 INFO - TEST-INFO | 25467: exit 0 11:58:03 INFO - TEST-OK | dromaeo_css | took 1114629ms 11:58:03 INFO - TEST-START | kraken 11:58:03 INFO - operating with platform_type : linux_ 11:58:03 INFO - Initialising browser for kraken test... 11:58:03 INFO - TEST-INFO | started process 25820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03f6za/profile http://localhost:50380/getInfo.html) 11:58:08 INFO - PROCESS | 25820 | __metrics Screen width/height:1600/1200 11:58:08 INFO - PROCESS | 25820 | colorDepth:24 11:58:08 INFO - PROCESS | 25820 | Browser inner width/height: 1024/697 11:58:08 INFO - PROCESS | 25820 | __metrics 11:58:08 ERROR - PROCESS | 25820 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 11:58:09 INFO - TEST-INFO | 25820: exit 0 11:58:09 INFO - Browser initialized. 11:58:09 INFO - Running cycle 1/1 for kraken test... 11:58:09 INFO - TEST-INFO | started process 25943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03f6za/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:21 INFO - PROCESS | 25943 | RSS: Main: 155701248 11:58:21 INFO - PROCESS | 25943 | 11:58:24 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:25 INFO - PROCESS | 25943 | RSS: Main: 160907264 11:58:25 INFO - PROCESS | 25943 | 11:58:27 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-dft) 11:58:28 INFO - PROCESS | 25943 | RSS: Main: 159793152 11:58:28 INFO - PROCESS | 25943 | 11:58:31 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-fft) 11:58:31 INFO - PROCESS | 25943 | RSS: Main: 156581888 11:58:31 INFO - PROCESS | 25943 | 11:58:34 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-oscillator) 11:58:34 INFO - PROCESS | 25943 | RSS: Main: 157671424 11:58:34 INFO - PROCESS | 25943 | 11:58:36 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:37 INFO - PROCESS | 25943 | RSS: Main: 157634560 11:58:37 INFO - PROCESS | 25943 | 11:58:40 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:41 INFO - PROCESS | 25943 | RSS: Main: 161550336 11:58:41 INFO - PROCESS | 25943 | 11:58:44 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:45 INFO - PROCESS | 25943 | RSS: Main: 162254848 11:58:45 INFO - PROCESS | 25943 | 11:58:47 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50380/tests/kraken/driver.html?testName=json-parse-financial) 11:58:48 INFO - PROCESS | 25943 | RSS: Main: 162127872 11:58:48 INFO - PROCESS | 25943 | 11:58:50 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:50 INFO - PROCESS | 25943 | RSS: Main: 162185216 11:58:50 INFO - PROCESS | 25943 | 11:58:52 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:53 INFO - PROCESS | 25943 | RSS: Main: 161693696 11:58:53 INFO - PROCESS | 25943 | 11:58:55 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:56 INFO - PROCESS | 25943 | RSS: Main: 161865728 11:58:56 INFO - PROCESS | 25943 | 11:58:58 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:59 INFO - PROCESS | 25943 | RSS: Main: 161320960 11:58:59 INFO - PROCESS | 25943 | 11:59:02 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:02 INFO - PROCESS | 25943 | RSS: Main: 161931264 11:59:02 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50380/tests/kraken/driver.html?testName=ai-astar) 11:59:04 INFO - PROCESS | 25943 | RSS: Main: 163848192 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | __start_tp_report 11:59:04 INFO - PROCESS | 25943 | _x_x_mozilla_page_load 11:59:04 INFO - PROCESS | 25943 | _x_x_mozilla_page_load_details 11:59:04 INFO - PROCESS | 25943 | |i|pagename|runs| 11:59:04 INFO - PROCESS | 25943 | |0;ai-astar;105;113;113;114;111;119;113;113;112;111 11:59:04 INFO - PROCESS | 25943 | |1;audio-beat-detection;150;120;127;155;125;126;124;121;140;121 11:59:04 INFO - PROCESS | 25943 | |2;audio-dft;165;165;161;162;165;171;165;165;163;163 11:59:04 INFO - PROCESS | 25943 | |3;audio-fft;75;78;78;113;81;78;78;77;97;78 11:59:04 INFO - PROCESS | 25943 | |4;audio-oscillator;84;83;105;83;84;83;101;83;87;103 11:59:04 INFO - PROCESS | 25943 | |5;imaging-gaussian-blur;118;119;118;117;118;117;118;117;119;118 11:59:04 INFO - PROCESS | 25943 | |6;imaging-darkroom;147;148;147;148;147;148;149;148;147;151 11:59:04 INFO - PROCESS | 25943 | |7;imaging-desaturate;96;97;96;96;97;97;97;97;97;97 11:59:04 INFO - PROCESS | 25943 | |8;json-parse-financial;56;57;58;58;61;59;60;59;56;58 11:59:04 INFO - PROCESS | 25943 | |9;json-stringify-tinderbox;68;69;68;68;68;67;68;68;68;69 11:59:04 INFO - PROCESS | 25943 | |10;stanford-crypto-aes;83;86;82;84;82;86;83;83;83;87 11:59:04 INFO - PROCESS | 25943 | |11;stanford-crypto-ccm;129;127;135;131;128;128;127;128;177;125 11:59:04 INFO - PROCESS | 25943 | |12;stanford-crypto-pbkdf2;174;170;169;175;177;169;165;170;167;171 11:59:04 INFO - PROCESS | 25943 | |13;stanford-crypto-sha256-iterative;68;63;63;65;63;64;66;64;65;62 11:59:04 INFO - PROCESS | 25943 | __end_tp_report 11:59:04 INFO - PROCESS | 25943 | __start_cc_report 11:59:04 INFO - PROCESS | 25943 | _x_x_mozilla_cycle_collect,761 11:59:04 INFO - PROCESS | 25943 | __end_cc_report 11:59:04 INFO - PROCESS | 25943 | __startTimestamp1484164744846__endTimestamp 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | ------- Summary: start ------- 11:59:04 INFO - PROCESS | 25943 | Number of tests: 14 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.44 (3.0%) stddev-sans-first:2.39 11:59:04 INFO - PROCESS | 25943 | Values: 105.0 113.0 113.0 114.0 111.0 119.0 113.0 113.0 112.0 111.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:126.50 stddev:12.76 (10.1%) stddev-sans-first:11.51 11:59:04 INFO - PROCESS | 25943 | Values: 150.0 120.0 127.0 155.0 125.0 126.0 124.0 121.0 140.0 121.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:2.72 (1.6%) stddev-sans-first:2.88 11:59:04 INFO - PROCESS | 25943 | Values: 165.0 165.0 161.0 162.0 165.0 171.0 165.0 165.0 163.0 163.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#3] audio-fft Cycles:10 Average:83.30 Median:78.00 stddev:12.13 (15.6%) stddev-sans-first:12.49 11:59:04 INFO - PROCESS | 25943 | Values: 75.0 78.0 78.0 113.0 81.0 78.0 78.0 77.0 97.0 78.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:9.37 (11.3%) stddev-sans-first:9.72 11:59:04 INFO - PROCESS | 25943 | Values: 84.0 83.0 105.0 83.0 84.0 83.0 101.0 83.0 87.0 103.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:59:04 INFO - PROCESS | 25943 | Values: 118.0 119.0 118.0 117.0 118.0 117.0 118.0 117.0 119.0 118.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 11:59:04 INFO - PROCESS | 25943 | Values: 147.0 148.0 147.0 148.0 147.0 148.0 149.0 148.0 147.0 151.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:59:04 INFO - PROCESS | 25943 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 97.0 97.0 97.0 97.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:1.62 (2.8%) stddev-sans-first:1.51 11:59:04 INFO - PROCESS | 25943 | Values: 56.0 57.0 58.0 58.0 61.0 59.0 60.0 59.0 56.0 58.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 11:59:04 INFO - PROCESS | 25943 | Values: 68.0 69.0 68.0 68.0 68.0 67.0 68.0 68.0 68.0 69.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:1.79 (2.1%) stddev-sans-first:1.87 11:59:04 INFO - PROCESS | 25943 | Values: 83.0 86.0 82.0 84.0 82.0 86.0 83.0 83.0 83.0 87.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:128.50 stddev:15.52 (12.1%) stddev-sans-first:16.38 11:59:04 INFO - PROCESS | 25943 | Values: 129.0 127.0 135.0 131.0 128.0 128.0 127.0 128.0 177.0 125.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:3.68 (2.2%) stddev-sans-first:3.71 11:59:04 INFO - PROCESS | 25943 | Values: 174.0 170.0 169.0 175.0 177.0 169.0 165.0 170.0 167.0 171.0 11:59:04 INFO - PROCESS | 25943 | 11:59:04 INFO - PROCESS | 25943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.77 (2.7%) stddev-sans-first:1.27 11:59:04 INFO - PROCESS | 25943 | Values: 68.0 63.0 63.0 65.0 63.0 64.0 66.0 64.0 65.0 62.0 11:59:04 INFO - PROCESS | 25943 | -------- Summary: end -------- 11:59:04 INFO - PROCESS | 25943 | 11:59:05 INFO - TEST-INFO | 25943: exit 0 11:59:05 INFO - TEST-OK | kraken | took 61977ms 11:59:05 INFO - SUITE-END | took 1176s 11:59:06 INFO - Completed test suite (00:19:36) 11:59:06 INFO - javascript benchmark 11:59:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.107994096811, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.968410315897, 3174.492081266996, 3179.976966760652, 3202.5196220566913, 3216.5979252593424, 5238.711870847102, 5348.064088784467, 5363.249145119681, 5377.462253774621, 5428.185772134182, 5264.315638966938, 5297.0, 5321.175217841241, 5344.732763361836, 5416.07926652469, 4821.13219620469, 4849.636277279201, 4875.8781030474165, 4974.875628109308, 4987.476314986929, 4864.270359446076, 4991.0, 5049.116404629193, 5054.494550544953, 5057.064443078024, 4818.68678535894, 4940.604751619898, 4964.503549645025, 4992.82525111623, 4996.850094497153, 4823.614110871122, 4831.951680483186, 4851.951480485185, 4854.2718592211095, 4966.677165984235, 4867.172580661296, 4873.244647079709, 4895.265710143507, 4904.877378065541, 4905.754712264373, 5289.7619607117385, 5301.814436494704, 5312.3093997780425, 5343.599230057761, 5344.866378340534, 5617.971910140464, 5628.831135065954, 5656.632318899258, 5659.0, 5674.0, 5762.596618236725, 5764.481196692276, 5771.0, 5771.365149833515, 5826.096954971986, 5327.813526526592, 5368.32895888014, 5377.462253774669, 5381.327334083239, 5381.3811411687375, 5743.282089738783, 5758.596898217168, 5773.422657734193, 5818.8254352369495, 5861.6189947653265, 5549.861253468695, 5613.494785469327, 5617.662940223599, 5665.971670141623, 5699.943000570024, 5666.490015898589, 5673.432656734293, 5720.656760594377, 5735.283089613798, 5743.684097374685, 5526.088195447786, 5575.135853942646, 5585.134304182858, 5675.744591493392, 5682.176084467729, 5670.716464176775, 5689.971550142222, 5690.089585666274, 5693.572982026365, 5695.943040569624, 4401.471823381151, 4439.955600444019, 4440.267355886307, 4440.777961101932, 4442.8667139985855, 3981.203759248162, 4020.1758639478835, 4057.6753859691153, 4062.045419326456, 4073.3889916512762, 5469.288992430958, 5499.092649712833, 5513.641613295204, 5522.806701765419, 5524.226608274765, 5593.860153496195, 5628.774849005994, 5792.073268277056, 5827.0, 5837.503812175928, 5356.946430535722, 5423.701696406735, 5424.891502170013, 5497.532709719719, 5537.750801213955, 4925.335079764258, 4948.38145231846, 4958.082754690394, 4958.603311735053, 4996.975015124974, 5831.533477321719, 5946.464818166386, 5956.731947062306, 5957.79147729836, 5971.5222782177325, 5646.3788983212635, 5678.74445649955, 5680.4319568042865, 5786.710664466844, 5801.738921748447, 5907.763689452546, 5925.407459254213, 5939.0, 5939.821805345847, 5948.434898684618, 5624.690642014729, 5639.7180140993605, 5643.379228284967, 5647.068233741551, 5653.123765816305, 5559.499645031967, 5595.972020139873, 5705.515031222392, 5709.600327977002, 5756.366799652119, 5623.775048997994, 5657.3776884543495, 5661.971690141688, 5667.688277144632, 5720.3707592165665, 5632.493075623213, 5643.068893632505, 5650.971745141248, 5692.5730570208225, 5699.116636921284, 5392.352917649907, 5410.0, 5426.755795989111, 5515.806946757005, 5606.607537472338, 5597.944020559742, 5601.719914004202, 5606.0469720148485, 5640.60515763909, 5650.576206784425, 5464.699441530595, 5470.234167216513, 5470.234167216672, 5475.698836564027, 5477.315335583052], "value": 5294.286987150124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9035918714225, 568.2499101186432, 575.3383608849822, 582.254713966123, 590.8641012567109, 43831.78084109579, 45095.77452112739, 46539.76730116349, 51705.48294517063, 51872.48127518724, 48458.0, 48935.51064489363, 48961.755191223994, 49029.50970490294, 49123.263151052764, 8977.730668079968, 9183.816323673522, 9185.632574697003, 10492.737681557946, 10756.085732712729, 10612.734681632983, 10695.304805187678, 10704.090152337061, 10706.250562460631, 10735.463226838667, 10750.354978701263, 10762.515686794113, 10762.892371076307, 10785.676429707122, 10831.620893268699, 10571.73570660732, 10633.149348052177, 10652.307600006052, 10677.305975111592, 10710.732231694192, 10608.15134789215, 10670.0, 10681.465926703711, 10707.304025238334, 10752.677419677422, 40783.0, 40965.79517102396, 40982.59017409818, 41016.0, 41143.794281028706, 3825.428612807696, 3838.42423636454, 3839.78881161536, 3857.1128640412862, 3928.3125453045886, 30709.692903070907, 30973.845130774203, 30979.661420132474, 30997.38005239905, 31487.527687084712, 4139.317012692902, 4216.494020717503, 4268.445102136733, 4280.871573852789, 4294.377315289296, 330630.0, 334096.0, 334988.0, 336502.0, 336979.0, 55852.0, 56167.71916140475, 56238.0, 56394.43605563974, 56559.717201414554, 58438.12342814776, 58707.30341572664, 58735.41264587385, 59070.70464647735, 59236.0, 16702.164891755365, 17139.828601714074, 17161.65676686459, 17209.569760755832, 17223.13884305805, 12372.566960156351, 12521.812172817416, 12543.749125017448, 12799.232046077264, 12823.807642885364, 18139.365122220657, 18238.452846414628, 18266.36067737623, 18450.0, 18628.441146765617, 7057.89413158803, 7158.2841715829045, 7202.783916482514, 7227.16887557927, 7250.492465527468, 926.8656044873455, 946.6024269806697, 949.8147861167006, 964.252704154286, 974.1248097412453, 31018.0, 31584.684153158632, 31983.360332793214, 32373.838130809665, 32803.34393312121, 1112.4882554025078, 1115.4255558387438, 1131.3890499130378, 1143.7598104398169, 1165.3241120150292, 17148.657026859393, 17267.309307627555, 17284.22221000058, 17335.91332043357, 17504.91247543754, 477201.0, 479896.0, 480685.0, 480710.0, 482159.0, 65872.34127658758, 66560.33439665638, 66655.33344666589, 66728.99626022358, 66729.33270667231, 1463.8389777124507, 1514.7727840823964, 1516.9696606067816, 1517.2413793103449, 1522.8401017893184, 30553.847230763702, 31463.84268078645, 31911.84044079765, 32094.67905320917, 32162.678373216906, 55512.0, 57161.42773575116, 57208.71395642995, 57472.0, 57522.712386439474, 394680.0, 395475.0, 396076.0, 396515.0, 396714.0, 25910.74089259083, 26490.86754566215, 29174.124776256747, 44926.77536612296, 45836.31245531253, 46353.304700428846, 51443.228351575504, 51702.22446663379, 52231.73884130555, 52722.736386317825, 42408.36387454129, 42773.0, 42921.785391074096, 44340.55659443364, 44999.32501012553, 43605.0, 43823.56176438322, 43877.34183987179, 44131.338029928935, 45333.54666453293, 44103.558964409945, 44328.11343773171, 44417.555824442636, 44603.55396445994, 45090.549094508635, 36948.261034779694, 39643.0, 39830.80084599558, 39835.20329593334, 40459.79770101131, 29250.707492924797, 29394.82420703148, 29613.85193074107, 29938.25154371071, 29975.0], "value": 21005.94298145216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.1921349436073, 429.0691982069323, 430.7889134324181, 431.26684636118597, 441.9801108950099, 19284.3250486233, 20708.689369659467, 21212.57574848504, 21951.0, 22065.227717029906, 21295.68056479154, 21552.137914483443, 21561.1375544978, 21592.2442714505, 21733.67399489009, 5736.426357364261, 5938.792142275021, 5940.168376427282, 5956.315023772278, 5961.254843144607, 5622.943770562303, 5729.226554415163, 5735.827925162252, 5737.397573254811, 5754.97122514389, 5520.392756796749, 5699.145128230757, 5703.116017017369, 5719.370869204384, 5723.828285151452, 5735.541156707474, 5765.769369225226, 5770.538356931435, 5822.82531524055, 5825.271841019851, 5186.974065129688, 5221.634485586011, 5234.947650523484, 5248.868778280574, 5256.92114618281, 23980.64029039566, 24457.877710611512, 24727.25818225456, 24795.13217037395, 24861.254162375157, 2702.162329677806, 2715.954357572329, 2731.262559109049, 2739.5342791725257, 2773.0, 14930.059092318037, 15295.694086118327, 15537.844621553753, 15644.921775391163, 16042.83957160425, 2010.7976263069436, 2025.7771645119026, 2033.1765634917733, 2041.9591608167902, 2079.376187143866, 85379.57310213472, 85638.0, 87982.0, 88160.11839881583, 89912.55043724805, 11339.603113890975, 11353.148513861328, 11525.76948461026, 11544.422778861024, 11579.536818527165, 15851.762223566655, 15976.360945562279, 15983.44057957966, 15995.280212390471, 16022.118783467022, 8407.495550267004, 8479.279261262738, 8610.397272191012, 8660.913390866137, 8669.176428239307, 7964.721234756872, 8047.235512626291, 8106.513609183467, 8303.916960830315, 8357.414980951275, 7080.185778635419, 7128.287171282934, 7144.8928266076055, 7243.4929554931705, 7348.963255183797, 1977.891215983106, 2046.8669536480081, 2054.298597344487, 2067.6174907642135, 2118.6504226802713, 985.6008316631633, 988.7429268390271, 995.4077323992213, 995.4276291132628, 999.9450030248406, 19988.50028749264, 20219.292324768856, 20428.182872684927, 20444.28445004418, 20696.379108626767, 1003.3779056984716, 1005.1657124586576, 1012.3116280928891, 1026.414943482223, 1029.711680729397, 10997.945010274898, 11765.88234117665, 11828.290302581701, 11869.46587403569, 11952.462139203757, 588028.0, 631648.0, 635231.0, 642007.0, 647019.0, 86434.0, 88424.0, 89476.55261723649, 89606.55196723975, 91003.54498227466, 1074.9465523786575, 1125.8536390269212, 1126.2904370246692, 1135.6706555098929, 1136.2160109524402, 17904.0, 18516.444506664822, 18626.81373186251, 18792.718109228645, 18910.432687019413, 36855.81572092122, 39764.80117599393, 41556.792216038724, 43148.78425607852, 45293.77353113213, 57613.71193144008, 58433.70783146057, 59376.0, 60257.698711506164, 60466.39533604607, 6579.440747536513, 8755.956220218859, 9032.63869445215, 9079.90920090817, 9383.765405864908, 7715.652795624323, 11632.302061876315, 12146.60314063894, 13258.403371848097, 14134.08128471646, 11712.238704484182, 11834.881651183723, 12025.819612705642, 12086.0, 12231.388430578614, 11514.36670983104, 11628.244164129304, 11648.301101933912, 11673.649790506299, 11789.115816313639, 11876.0, 12136.939315303367, 12205.450754715881, 12292.508299667914, 12531.122821402414, 9085.90914090877, 9191.862122068309, 9200.493972831558, 9224.44653320776, 9459.621615135318, 9376.859347109663, 12084.577039803564, 12213.816792748294, 12305.692357691129, 12443.37783110859], "value": 9811.701635234753, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.7278330725505, 1396.7136736968923, 1401.0752903083967, 1407.4088882669278, 1407.957761267162, 7421.2949769771785, 7666.540007599534, 8150.470219435732, 8693.47839129652, 8710.60802263898, 8209.09699933007, 8323.750287491384, 8416.116307787686, 8636.13638636136, 8685.609147588359, 2177.8693278403266, 2222.9777702223014, 2241.531796673182, 2247.2471721973156, 2251.167068184766, 2169.858959167657, 2232.520008198237, 2235.5417139486367, 2247.8876056197205, 2291.9885400573057, 2233.3300009997015, 2239.8320125990535, 2241.607718649238, 2251.0883092347626, 2254.165958595314, 2213.9335819925427, 2226.076178385968, 2248.7751224877543, 2252.8986195621237, 2271.466205441728, 2158.3093410108772, 2221.8444708870384, 2240.484688521633, 2312.7571604981404, 2319.408550819547, 8563.687804292806, 8574.571271436404, 8577.313814894793, 8613.956930215372, 8621.525816080113, 5163.044836705221, 5249.291345668324, 5270.183121616155, 5283.682979021271, 5294.788208471657, 3161.0, 3317.8672853085845, 3375.662433756629, 3381.2730262993573, 3403.2172600301824, 1296.556362125918, 1325.8796317112026, 1336.859629738873, 2043.9591208175902, 2053.7330147080784, 11111.499982500725, 11137.997580217738, 11146.554137834477, 11214.10287177024, 11249.0, 4261.957380426156, 4376.562343765598, 4458.9331160032625, 4459.152760975404, 4516.1419330327135, 9119.589618467186, 9259.537023148816, 9275.536223188948, 9328.766780830534, 9352.392094513834, 5277.050130976384, 5293.761780719877, 5293.947060529423, 5297.390800057966, 5297.788088476418, 4710.882227944328, 4808.543188397097, 4871.123197824355, 4878.268259760993, 4915.754212289371, 3406.131436483681, 3489.877854275139, 3529.2412131391875, 3559.6440355964196, 3562.928741425157, 1039.184240371305, 1059.7986382587283, 1093.4805967165692, 1106.1316866259947, 1119.3004372267333, 927.5779520318239, 931.9953400233092, 936.3445588088365, 946.5503885654259, 967.8161149381594, 5230.084735171406, 5459.50864422196, 5506.862328441821, 5572.637778544382, 5583.302087239095, 1015.1979935850743, 1015.3958394755109, 1018.251585084962, 1046.858674079005, 1049.9422531760827, 3475.8957231283102, 3572.732045096628, 3680.9079773005888, 3738.925221495555, 3744.1575645480093, 9969.202463802878, 10293.176545876311, 10333.586656533806, 10452.790944181073, 10479.318844275098, 9932.304738668368, 10219.897801022043, 10244.282900196915, 10321.48392580383, 10342.32774869631, 7982.560959147187, 8014.959925200336, 8027.397945154137, 8098.473599215914, 8098.4735992161495, 5195.610329225399, 5293.285406470077, 5301.973490132679, 5303.787848486171, 5507.972460137674, 9191.126842949909, 9218.585163667785, 9219.308551858772, 9335.48654823964, 9356.485393303434, 9017.774555636162, 9362.625494980124, 9421.0, 9424.387414818015, 9681.757956051155, 7439.367653749492, 7550.848983020199, 7559.811004724926, 7572.962135189288, 7576.469647124648, 7165.605891675799, 8070.838583228185, 8073.19268073188, 8106.756797296091, 8153.268655000404, 6830.146231721035, 6833.077534532775, 6836.111305530249, 6885.173779146535, 7091.503594748318, 6525.836854078686, 6541.6402097885075, 6558.376954189344, 6570.934290657032, 6576.539642224999, 5666.46168613981, 5714.79998200061, 5716.628419152742, 5717.256756621613, 5744.965906136768, 4637.907241855211, 4655.674102812771, 4683.695559788603, 4737.952620473751, 4800.0399920016835, 4500.662450316305, 4528.41130653013, 4538.818447262072, 4573.611243044378, 4573.748443835488], "value": 4400.010130954161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4787441205549, 384.0590553144795, 388.94360317753933, 392.53680656824935, 397.14217290652164, 5164.509371609701, 5339.679619222849, 5369.731513424328, 5444.945550544493, 5472.480114389136, 5243.2659427680155, 5384.434634363394, 5384.842258914333, 5388.110961691326, 5392.97763338748, 4340.699429302459, 4353.303471444569, 4366.585174408426, 4368.689393182032, 4372.912541749163, 3997.6801855851463, 4192.454980852485, 4371.890702732441, 4390.990072283376, 4393.604575588196, 4142.917141657165, 4170.332746760519, 4173.520045194796, 4174.70777045607, 4178.892593462735, 4144.150449157915, 4144.1918825828825, 4148.62662360386, 4171.228322760299, 4220.831166753326, 3697.574778900434, 3702.777833330009, 3702.833372498244, 3703.740738148331, 3715.238376132886, 5106.540411362995, 5211.687298762048, 5222.895542089137, 5241.842744717665, 5247.553957913582, 4785.377900872899, 4787.712737235742, 4788.257820037899, 4810.735409552473, 4818.939833236717, 5512.810264199197, 5687.203791469197, 5696.430356964312, 5700.201971723962, 5717.113847353667, 3978.403239514096, 4019.256437559061, 4033.4353190553347, 4049.8582549610624, 4050.453188819501, 5880.353161152269, 5894.646321220741, 5909.281730404019, 5920.0, 5956.851078723023, 4110.0, 4118.0, 4122.670186385082, 4127.29835927887, 4134.276501612206, 4023.8390464381096, 4135.524414692289, 4169.687273454503, 4205.8527951522165, 4215.220184265921, 4727.905441891212, 4778.426588809296, 4778.976105119522, 4780.402449693788, 4809.3548548298995, 5688.208214412447, 5707.086866101404, 5719.256496655491, 5729.455701708331, 5750.5112065474905, 1466.7433199190311, 1491.8955673102778, 1493.6863258715573, 1502.8647421731878, 1506.5160816595644, 1010.5604062232952, 1023.6743417274647, 1031.7781676939494, 1042.7966546523355, 1054.757405796671, 5233.267342572043, 5256.658317209369, 5261.184516399964, 5265.21021846726, 5310.415854256029, 5617.820257745919, 5639.238702775073, 5670.206171135962, 5670.829875103754, 5737.3688894221605, 4994.450610432849, 5211.2443695663915, 5267.341582302212, 5310.787568497294, 5330.987112448623, 2935.8678859451375, 2959.230600044004, 2965.8961936332125, 2972.3758010817537, 2993.3115383461927, 5750.338711048199, 5836.241288632451, 5846.649201047951, 5848.824535263949, 5869.559783016291, 5424.884295124904, 5654.46282603152, 5713.8285851424525, 5717.313922329347, 5727.5131613812455, 5761.0, 5764.452377024176, 5767.942320576824, 5781.595288329777, 5783.971080144573, 5391.32608423947, 5645.745941432563, 5646.237757902631, 5650.915236271377, 5745.396733342939, 5753.784792854697, 5768.769249229984, 5779.479846813807, 5786.971065144648, 5799.710014499174, 6039.245094363205, 6044.909326360196, 6080.817575472743, 6081.0, 6109.7861574844665, 3951.0714981978635, 4098.077932465171, 4100.7334523255895, 4121.91756164881, 4142.2958097124165, 5815.476607105381, 5854.443827836349, 5854.502367298827, 5878.529717622494, 5878.736071744595, 5507.284053073075, 5705.286839145107, 5751.7411716472025, 5753.683547404933, 5771.971140144273, 5643.209950607001, 5661.2923384576925, 5675.631083979528, 5682.573806964577, 5716.79991200306, 5670.8015219467125, 5675.914861277001, 5676.574256930664, 5702.946939101837, 5721.942780572307, 5500.779968801203, 5666.688332141772, 5710.057840456278, 5712.685802280915, 5754.625949313281, 5598.720063996865, 5602.635828671123, 5617.297837770278, 5617.859553511195, 5642.319898048559], "value": 4325.148219015064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.763657446745, 724.7535837815142, 785.7367781793099, 788.8777239527875, 808.7735434078453, 14087.718245635082, 14984.400623975029, 14989.925050374733, 14995.40018399264, 15017.62455938602, 15138.54584362468, 15310.770338444932, 15317.693646127098, 15344.923275383635, 15359.078455292662, 625.9123722678829, 645.0614356111846, 707.4941416886937, 713.6645776485044, 730.722325516303, 741.7366834773659, 744.5867543513348, 745.4111252110825, 745.6532712288785, 746.5632604926097, 772.6561680052379, 778.5484419036974, 779.0962483519119, 782.2724865874734, 782.7808213700173, 773.5397438524097, 777.3392616276177, 779.4271210660161, 779.8479296537178, 780.9140994490601, 568.4230506036376, 568.5196009372115, 568.7696482924422, 569.049687022669, 572.7336788393417, 14551.3451894665, 14729.189894555795, 15213.087214767038, 15224.238788060664, 15298.847011529853, 11419.48612312448, 13207.801882971764, 13939.930300348535, 13971.301434928315, 14045.43818247269, 11382.715432114263, 11578.421078946103, 11724.648260552112, 11831.112666549958, 11883.40582970848, 3687.631236876318, 3700.0749812546865, 3734.7945862977526, 3811.1805961718087, 3882.437046628251, 73822.0, 75615.62192189059, 75958.0, 76706.0, 77343.6132819338, 10945.233833631728, 10972.835407468894, 10975.176861735401, 11091.83362249567, 11107.389093599768, 21021.894890525757, 21138.894305528374, 21170.47073823136, 21218.469538261666, 21240.575188496452, 7127.358537731629, 7243.058402407653, 7485.663145158481, 7490.475666703279, 7655.846883062308, 4353.869383918424, 4415.4259946206785, 4427.889302767457, 4499.752513611717, 4504.346869703874, 3464.0300715799617, 3567.9821600892346, 3579.7673151245085, 3580.6240344763423, 3583.4087375582735, 633.8573820890263, 639.1052526462989, 646.8415238266655, 650.9446697030711, 667.9799606011827, 797.6649807081039, 805.1264378149656, 820.729159377404, 827.8385714785559, 839.5969934431507, 9619.615215391446, 9623.56693948774, 10271.589136434459, 10556.26106172576, 10827.729306767236, 606.8998615228438, 610.9877802444015, 622.8785386849612, 628.1488582970101, 634.2199095112944, 4813.4945830687975, 4975.601951843843, 5007.198848184273, 5023.522765337287, 5025.6482046256415, 80907.59546202232, 81479.0, 82300.58849705833, 85150.57424712837, 85531.0, 63259.73480530456, 70302.0, 71549.0, 71598.28401715917, 73625.47808914246, 63076.684616576626, 63445.68277158677, 65164.67417662881, 66194.66902665552, 66261.66869165623, 9355.625774968925, 9760.707178784647, 10204.59181632756, 10699.89300106989, 10912.181586380895, 40313.0, 40851.387229190994, 41008.1798364037, 41126.58873411347, 42226.788866055475, 49688.75155624199, 51074.0, 51574.484255158466, 52661.21008184804, 53105.73447132894, 12374.443150058449, 12476.625701228977, 12710.173838700455, 12717.491300348252, 12883.291418971672, 13166.736665266833, 13317.13438626525, 13362.198268103944, 13441.596752097452, 13547.864521355055, 12237.877621223673, 12276.0, 12327.312430513792, 12644.936775316064, 13803.0, 12793.936030319788, 13146.0, 13246.403911824184, 13401.463941442624, 13882.5734912848, 12546.560870369492, 12978.480860765463, 13264.86735132675, 13717.0, 13800.378982945993, 11033.337999720043, 11220.688797712297, 11383.829242561535, 11577.594784182513, 11867.465964031811, 10282.640107596199, 10695.572177112828, 10872.945635271773, 10975.396353200651, 11028.338299701723], "value": 7051.168170470514, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 114.0, 111.0, 119.0, 113.0, 113.0, 112.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 127.0, 155.0, 125.0, 126.0, 124.0, 121.0, 140.0, 121.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 162.0, 165.0, 171.0, 165.0, 165.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 78.0, 113.0, 81.0, 78.0, 78.0, 77.0, 97.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 83.0, 84.0, 83.0, 101.0, 83.0, 87.0, 103.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 151.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 61.0, 59.0, 60.0, 59.0, 56.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 82.0, 84.0, 82.0, 86.0, 83.0, 83.0, 83.0, 87.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 135.0, 131.0, 128.0, 128.0, 127.0, 128.0, 177.0, 125.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 169.0, 175.0, 177.0, 169.0, 165.0, 170.0, 167.0, 171.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 63.0, 65.0, 63.0, 64.0, 66.0, 64.0, 65.0, 62.0], "value": 64.3, "unit": "score"}]}]} 11:59:06 INFO - Return code: 0 11:59:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:06 ERROR - # TBPL SUCCESS # 11:59:06 INFO - Running post-action listener: _resource_record_post_action 11:59:06 INFO - [mozharness: 2017-01-11 19:59:06.174421Z] Finished run-tests step (success) 11:59:06 INFO - Running post-run listener: _resource_record_post_run 11:59:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400093184; Read time: 8; Write time: 336628 11:59:06 INFO - TinderboxPrint: CPU usage
13.4% 11:59:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:59:06 INFO - TinderboxPrint: I/O write bytes / time
400,093,184 / 336,628 11:59:06 INFO - TinderboxPrint: CPU idle
8,251.3 (86.6%) 11:59:06 INFO - TinderboxPrint: CPU user
1,215.4 (12.8%) 11:59:06 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105676800; Read time: 0; Write time: 103876 11:59:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294416384; Read time: 8; Write time: 232752 11:59:06 INFO - Running post-run listener: _upload_blobber_files 11:59:06 INFO - Blob upload gear active. 11:59:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:06 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:59:06 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:59:06 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:59:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:08 INFO - (blobuploader) - INFO - Done attempting. 11:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:08 INFO - (blobuploader) - INFO - Done attempting. 11:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:12 INFO - (blobuploader) - INFO - Done attempting. 11:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:13 INFO - (blobuploader) - INFO - Done attempting. 11:59:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:13 INFO - Return code: 0 11:59:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d2e0183461dd3ff08d11afbc1586f940aa06c0d49c407dd2be6c60b2a4bbeb851e1df08acb79bbbd70bfe80df1d5736fe77cce17e59333f47db5113b1864100", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a531ba803c067d14ce8f00f361328652949040ab2e05a34624d6bee485e5cb79c5c904bde94f72be1c7e5705cc2297eecc759f2a0c8c7d070b7c88f5a73591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea3bcdb2fd09d14d03ab522724695477321dba05d71e466e70d4ace34b0b88c9d938eb82546f14cd38ceff755d179f28656da326235a00015f06afc42a5c41a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ee32dc1d53444433f21eead785089fffb6600d879b3427d665457421236291047f4dbb6c5e64a8bc7dde69a25b83c74a5469a6247975c5fd8be825e7d493a8e"} 11:59:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:13 INFO - Contents: 11:59:13 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d2e0183461dd3ff08d11afbc1586f940aa06c0d49c407dd2be6c60b2a4bbeb851e1df08acb79bbbd70bfe80df1d5736fe77cce17e59333f47db5113b1864100", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a531ba803c067d14ce8f00f361328652949040ab2e05a34624d6bee485e5cb79c5c904bde94f72be1c7e5705cc2297eecc759f2a0c8c7d070b7c88f5a73591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea3bcdb2fd09d14d03ab522724695477321dba05d71e466e70d4ace34b0b88c9d938eb82546f14cd38ceff755d179f28656da326235a00015f06afc42a5c41a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ee32dc1d53444433f21eead785089fffb6600d879b3427d665457421236291047f4dbb6c5e64a8bc7dde69a25b83c74a5469a6247975c5fd8be825e7d493a8e"} 11:59:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:13 INFO - Copying logs to upload dir... 11:59:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.458228 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-11 11:59:13.139252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 11:59:13.142707) ========= 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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 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/7d2e0183461dd3ff08d11afbc1586f940aa06c0d49c407dd2be6c60b2a4bbeb851e1df08acb79bbbd70bfe80df1d5736fe77cce17e59333f47db5113b1864100", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a531ba803c067d14ce8f00f361328652949040ab2e05a34624d6bee485e5cb79c5c904bde94f72be1c7e5705cc2297eecc759f2a0c8c7d070b7c88f5a73591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea3bcdb2fd09d14d03ab522724695477321dba05d71e466e70d4ace34b0b88c9d938eb82546f14cd38ceff755d179f28656da326235a00015f06afc42a5c41a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ee32dc1d53444433f21eead785089fffb6600d879b3427d665457421236291047f4dbb6c5e64a8bc7dde69a25b83c74a5469a6247975c5fd8be825e7d493a8e"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011799 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484156384/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/7d2e0183461dd3ff08d11afbc1586f940aa06c0d49c407dd2be6c60b2a4bbeb851e1df08acb79bbbd70bfe80df1d5736fe77cce17e59333f47db5113b1864100", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85a531ba803c067d14ce8f00f361328652949040ab2e05a34624d6bee485e5cb79c5c904bde94f72be1c7e5705cc2297eecc759f2a0c8c7d070b7c88f5a73591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea3bcdb2fd09d14d03ab522724695477321dba05d71e466e70d4ace34b0b88c9d938eb82546f14cd38ceff755d179f28656da326235a00015f06afc42a5c41a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ee32dc1d53444433f21eead785089fffb6600d879b3427d665457421236291047f4dbb6c5e64a8bc7dde69a25b83c74a5469a6247975c5fd8be825e7d493a8e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 11:59:13.169246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:59:13.169610) ========= 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=d2a8c569965ab8367867b893000001a1-1484163514.270621-457688300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 11:59:13.252535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 11:59:13.252920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 11:59:13.253286) ========= ========= Total master_lag: 0.17 =========